builder: larch_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0132 starttime: 1470072455.87 results: success (0) buildid: 20160801083949 builduid: 5ca87bec3cf74b27a29405faa19d49b7 revision: 530dc1b58520ac87909eed9f22633712d5003830 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:35.874216) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:35.874790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:35.875102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:36.027523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:36.027805) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STJcujnKxB/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-08-01 10:27:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.7M=0.001s 2016-08-01 10:27:36 (14.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.511444 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:36.564276) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:36.564709) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STJcujnKxB/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020463 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:36.616188) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 10:27:36.616545) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 530dc1b58520ac87909eed9f22633712d5003830 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 530dc1b58520ac87909eed9f22633712d5003830 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STJcujnKxB/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-08-01 10:27:36,693 truncating revision to first 12 chars 2016-08-01 10:27:36,693 Setting DEBUG logging. 2016-08-01 10:27:36,693 attempt 1/10 2016-08-01 10:27:36,693 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/530dc1b58520?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-01 10:27:37,829 unpacking tar archive at: larch-530dc1b58520/testing/mozharness/ program finished with exit code 0 elapsedTime=1.413847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-01 10:27:38.054016) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:38.054350) ========= script_repo_revision: 530dc1b58520ac87909eed9f22633712d5003830 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:38.054769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:38.055075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-01 10:27:38.073319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-01 10:27:38.073675) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 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', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STJcujnKxB/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 10:27:38 INFO - MultiFileLogger online at 20160801 10:27:38 in /builds/slave/test 10:27:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 10:27:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:27:38 INFO - {'append_to_log': False, 10:27:38 INFO - 'base_work_dir': '/builds/slave/test', 10:27:38 INFO - 'blob_upload_branch': 'Larch', 10:27:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:27:38 INFO - 'branch': 'Larch', 10:27:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:27:38 INFO - 'config_files': ('talos/mac_config.py',), 10:27:38 INFO - 'default_actions': ('clobber', 10:27:38 INFO - 'read-buildbot-config', 10:27:38 INFO - 'download-and-extract', 10:27:38 INFO - 'populate-webroot', 10:27:38 INFO - 'create-virtualenv', 10:27:38 INFO - 'install', 10:27:38 INFO - 'run-tests'), 10:27:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:27:38 INFO - 'download_minidump_stackwalk': True, 10:27:38 INFO - 'download_symbols': 'ondemand', 10:27:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:27:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:27:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:27:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:27:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:27:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:27:38 INFO - 'installer_path': 'installer.exe', 10:27:38 INFO - 'log_level': 'info', 10:27:38 INFO - 'log_name': 'talos', 10:27:38 INFO - 'log_to_console': True, 10:27:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:27:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:27:38 INFO - 'opt_config_files': (), 10:27:38 INFO - 'pip_index': False, 10:27:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:27:38 INFO - 'cmd': ('bash', 10:27:38 INFO - '-c', 10:27:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:27:38 INFO - 'enabled': True, 10:27:38 INFO - 'halt_on_failure': False, 10:27:38 INFO - 'name': 'check_screen_resolution'},), 10:27:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:27:38 INFO - 'cmd': ('bash', 10:27:38 INFO - '-c', 10:27:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:27:38 INFO - 'enabled': True, 10:27:38 INFO - 'halt_on_failure': False, 10:27:38 INFO - 'name': 'check_screen_resolution'},), 10:27:38 INFO - 'run_cmd_checks_enabled': True, 10:27:38 INFO - 'sps_profile': False, 10:27:38 INFO - 'sps_profile_interval': 0, 10:27:38 INFO - 'suite': 'dromaeojs', 10:27:38 INFO - 'system_bits': '32', 10:27:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:27:38 INFO - 'title': 't-yosemite-r7-0132', 10:27:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:27:38 INFO - 'use_talos_json': True, 10:27:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:27:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:27:38 INFO - 'work_dir': 'build'} 10:27:38 INFO - ##### 10:27:38 INFO - ##### Running clobber step. 10:27:38 INFO - ##### 10:27:38 INFO - Running pre-action listener: _resource_record_pre_action 10:27:38 INFO - Running main action method: clobber 10:27:38 INFO - rmtree: /builds/slave/test/build 10:27:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:27:39 INFO - Running post-action listener: _resource_record_post_action 10:27:39 INFO - ##### 10:27:39 INFO - ##### Finished clobber step (success) 10:27:39 INFO - ##### 10:27:39 INFO - ##### 10:27:39 INFO - ##### Running read-buildbot-config step. 10:27:39 INFO - ##### 10:27:39 INFO - Running pre-action listener: _resource_record_pre_action 10:27:39 INFO - Running main action method: read_buildbot_config 10:27:39 INFO - Using buildbot properties: 10:27:39 INFO - { 10:27:39 INFO - "project": "", 10:27:39 INFO - "product": "firefox", 10:27:39 INFO - "script_repo_revision": "production", 10:27:39 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs", 10:27:39 INFO - "repository": "", 10:27:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs", 10:27:39 INFO - "buildid": "20160801083949", 10:27:39 INFO - "pgo_build": "False", 10:27:39 INFO - "basedir": "/builds/slave/test", 10:27:39 INFO - "buildnumber": 1, 10:27:39 INFO - "slavename": "t-yosemite-r7-0132", 10:27:39 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:27:39 INFO - "platform": "yosemite_r7", 10:27:39 INFO - "scheduler": "tests-larch-macosx64-talos", 10:27:39 INFO - "branch": "larch", 10:27:39 INFO - "repo_path": "projects/larch", 10:27:39 INFO - "revision": "530dc1b58520ac87909eed9f22633712d5003830", 10:27:39 INFO - "stage_platform": "macosx64", 10:27:39 INFO - "builduid": "5ca87bec3cf74b27a29405faa19d49b7", 10:27:39 INFO - "slavebuilddir": "test" 10:27:39 INFO - } 10:27:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 10:27:39 INFO - Running post-action listener: _resource_record_post_action 10:27:39 INFO - ##### 10:27:39 INFO - ##### Finished read-buildbot-config step (success) 10:27:39 INFO - ##### 10:27:39 INFO - ##### 10:27:39 INFO - ##### Running download-and-extract step. 10:27:39 INFO - ##### 10:27:39 INFO - Running pre-action listener: _resource_record_pre_action 10:27:39 INFO - Running main action method: download_and_extract 10:27:39 INFO - mkdir: /builds/slave/test/build/tests 10:27: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:27:39 INFO - https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:27:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:27:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 10:27:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:27:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 10:27:48 INFO - Downloaded 1199 bytes. 10:27:48 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 10:27:48 INFO - Using the following test package requirements: 10:27:48 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:27:48 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 10:27:48 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 10:27:48 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'jsshell-mac.zip'], 10:27:48 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 10:27:48 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 10:27:48 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 10:27:48 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 10:27:48 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 10:27:48 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 10:27:48 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 10:27:48 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:27:48 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:27:48 INFO - https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:27:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:27:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:27:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:27:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:27:50 INFO - Downloaded 18789523 bytes. 10:27:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:27:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:27:53 INFO - Return code: 0 10:27:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:27:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:27:53 INFO - https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:27:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:27:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:27:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 10:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:27:56 INFO - Downloaded 18789523 bytes. 10:27:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:27:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:27:59 INFO - Return code: 0 10:27: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:27:59 INFO - https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:27:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:27:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:27:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 10:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:28:01 INFO - Downloaded 14405242 bytes. 10:28:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:28:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:28:01 INFO - Return code: 0 10:28:01 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:01 INFO - https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:28:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:28:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:28:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 10:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 10:28:04 INFO - Downloaded 112479116 bytes. 10:28:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:28:04 INFO - mkdir: /builds/slave/test/properties 10:28:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:28:04 INFO - Writing to file /builds/slave/test/properties/build_url 10:28:04 INFO - Contents: 10:28:04 INFO - build_url:https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 10:28:04 INFO - Running post-action listener: _resource_record_post_action 10:28:04 INFO - Running post-action listener: set_extra_try_arguments 10:28:04 INFO - ##### 10:28:04 INFO - ##### Finished download-and-extract step (success) 10:28:04 INFO - ##### 10:28:04 INFO - ##### 10:28:04 INFO - ##### Running populate-webroot step. 10:28:04 INFO - ##### 10:28:04 INFO - Running pre-action listener: _resource_record_pre_action 10:28:04 INFO - Running main action method: populate_webroot 10:28:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:28:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:28:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:28:04 INFO - '--tppagecycles', 10:28:04 INFO - '7'], 10:28:04 INFO - 'tests': ['tsvgm']}}, 10:28:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:28:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:28:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:28:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:28:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:28:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['damp', 'tps']}, 10:28:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'tests': ['damp', 'tps']}, 10:28:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['dromaeo_dom']}, 10:28:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:28:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['basic_compositor_video']}, 10:28:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:28:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['a11yr', 10:28:04 INFO - 'ts_paint', 10:28:04 INFO - 'tpaint', 10:28:04 INFO - 'sessionrestore', 10:28:04 INFO - 'sessionrestore_no_auto_restore', 10:28:04 INFO - 'tabpaint']}, 10:28:04 INFO - 'other-e10s': {'tests': ['a11yr', 10:28:04 INFO - 'ts_paint', 10:28:04 INFO - 'tpaint', 10:28:04 INFO - 'sessionrestore', 10:28:04 INFO - 'sessionrestore_no_auto_restore', 10:28:04 INFO - 'tabpaint']}, 10:28:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:28:04 INFO - 'ts_paint', 10:28:04 INFO - 'tpaint', 10:28:04 INFO - 'sessionrestore', 10:28:04 INFO - 'sessionrestore_no_auto_restore', 10:28:04 INFO - 'tabpaint']}, 10:28:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:28:04 INFO - 'ts_paint', 10:28:04 INFO - 'tpaint', 10:28:04 INFO - 'sessionrestore', 10:28:04 INFO - 'sessionrestore_no_auto_restore', 10:28:04 INFO - 'tabpaint']}, 10:28:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['a11yr', 10:28:04 INFO - 'ts_paint', 10:28:04 INFO - 'tpaint', 10:28:04 INFO - 'sessionrestore', 10:28:04 INFO - 'sessionrestore_no_auto_restore', 10:28:04 INFO - 'tabpaint']}, 10:28:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['a11yr', 10:28:04 INFO - 'ts_paint', 10:28:04 INFO - 'tpaint', 10:28:04 INFO - 'sessionrestore', 10:28:04 INFO - 'sessionrestore_no_auto_restore', 10:28:04 INFO - 'tabpaint']}, 10:28:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['tsvgx', 10:28:04 INFO - 'tsvgr_opacity', 10:28:04 INFO - 'tart', 10:28:04 INFO - 'tscrollx', 10:28:04 INFO - 'cart']}, 10:28:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:28:04 INFO - 'tsvgr_opacity', 10:28:04 INFO - 'tart', 10:28:04 INFO - 'tscrollx', 10:28:04 INFO - 'cart']}, 10:28:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'talos_options': ['--disable-e10s'], 10:28:04 INFO - 'tests': ['tp5o']}, 10:28:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'tests': ['tp5o']}, 10:28:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'talos_options': ['--disable-e10s', 10:28:04 INFO - '--xperf_path', 10:28:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:04 INFO - 'tests': ['tp5n']}, 10:28:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:28:04 INFO - 'talos_options': ['--xperf_path', 10:28:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:28:04 INFO - 'tests': ['tp5n']}}, 10:28:04 INFO - 'talos.zip': {'path': '', 10:28:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:28:04 INFO - Running post-action listener: _resource_record_post_action 10:28:04 INFO - ##### 10:28:04 INFO - ##### Finished populate-webroot step (success) 10:28:04 INFO - ##### 10:28:04 INFO - ##### 10:28:04 INFO - ##### Running create-virtualenv step. 10:28:04 INFO - ##### 10:28:04 INFO - Running pre-action listener: _resource_record_pre_action 10:28:04 INFO - Running main action method: create_virtualenv 10:28:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:28:04 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:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:28:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:28:05 INFO - Using real prefix '/tools/python27' 10:28:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:28:05 INFO - Installing distribute.............................................................................................................................................................................................done. 10:28:08 INFO - Installing pip.................done. 10:28:08 INFO - Return code: 0 10:28:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:08 INFO - 'HOME': '/Users/cltbld', 10:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:08 INFO - 'LOGNAME': 'cltbld', 10:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:08 INFO - 'MOZ_NO_REMOTE': '1', 10:28:08 INFO - 'NO_EM_RESTART': '1', 10:28:08 INFO - 'PAGER': '/bin/cat', 10:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:08 INFO - 'PWD': '/builds/slave/test', 10:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:08 INFO - 'SHELL': '/bin/bash', 10:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:08 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:08 INFO - 'USER': 'cltbld', 10:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:08 INFO - 'XPC_FLAGS': '0x0', 10:28:08 INFO - 'XPC_SERVICE_NAME': '0', 10:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:08 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:08 INFO - Cleaning up... 10:28:08 INFO - Return code: 0 10:28:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:08 INFO - 'HOME': '/Users/cltbld', 10:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:08 INFO - 'LOGNAME': 'cltbld', 10:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:08 INFO - 'MOZ_NO_REMOTE': '1', 10:28:08 INFO - 'NO_EM_RESTART': '1', 10:28:08 INFO - 'PAGER': '/bin/cat', 10:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:08 INFO - 'PWD': '/builds/slave/test', 10:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:08 INFO - 'SHELL': '/bin/bash', 10:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:08 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:08 INFO - 'USER': 'cltbld', 10:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:08 INFO - 'XPC_FLAGS': '0x0', 10:28:08 INFO - 'XPC_SERVICE_NAME': '0', 10:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:09 INFO - Downloading/unpacking psutil>=3.1.1 10:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:28:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:12 INFO - Installing collected packages: psutil 10:28:12 INFO - Running setup.py install for psutil 10:28:12 INFO - building 'psutil._psutil_osx' extension 10:28:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:28:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:28:12 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:28:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:28:13 INFO - building 'psutil._psutil_posix' extension 10:28:13 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:28:13 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:28:13 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:28:13 INFO - ^ 10:28:13 INFO - 1 warning generated. 10:28:13 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:28:13 INFO - Successfully installed psutil 10:28:13 INFO - Cleaning up... 10:28:13 INFO - Return code: 0 10:28:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:13 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 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:13 INFO - 'HOME': '/Users/cltbld', 10:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:13 INFO - 'LOGNAME': 'cltbld', 10:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:13 INFO - 'MOZ_NO_REMOTE': '1', 10:28:13 INFO - 'NO_EM_RESTART': '1', 10:28:13 INFO - 'PAGER': '/bin/cat', 10:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:13 INFO - 'PWD': '/builds/slave/test', 10:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:13 INFO - 'SHELL': '/bin/bash', 10:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:13 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:13 INFO - 'USER': 'cltbld', 10:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:13 INFO - 'XPC_FLAGS': '0x0', 10:28:13 INFO - 'XPC_SERVICE_NAME': '0', 10:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:28:13 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:13 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:13 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:13 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:13 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:13 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:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:28:16 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:16 INFO - Installing collected packages: mozsystemmonitor 10:28:16 INFO - Running setup.py install for mozsystemmonitor 10:28:16 INFO - Successfully installed mozsystemmonitor 10:28:16 INFO - Cleaning up... 10:28:16 INFO - Return code: 0 10:28:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:28:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:28:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:16 INFO - 'HOME': '/Users/cltbld', 10:28:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:16 INFO - 'LOGNAME': 'cltbld', 10:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:16 INFO - 'MOZ_NO_REMOTE': '1', 10:28:16 INFO - 'NO_EM_RESTART': '1', 10:28:16 INFO - 'PAGER': '/bin/cat', 10:28:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:16 INFO - 'PWD': '/builds/slave/test', 10:28:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:16 INFO - 'SHELL': '/bin/bash', 10:28:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:16 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:16 INFO - 'USER': 'cltbld', 10:28:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:16 INFO - 'XPC_FLAGS': '0x0', 10:28:16 INFO - 'XPC_SERVICE_NAME': '0', 10:28:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:16 INFO - Downloading/unpacking jsonschema==2.5.1 10:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:28:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:19 INFO - Downloading functools32-3.2.3-2.tar.gz 10:28:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:28:19 INFO - warning: no files found matching '*.txt' 10:28:19 INFO - no previously-included directories found matching 'build' 10:28:19 INFO - no previously-included directories found matching 'dist' 10:28:19 INFO - no previously-included directories found matching '.git*' 10:28:19 INFO - Installing collected packages: jsonschema, functools32 10:28:19 INFO - Running setup.py install for functools32 10:28:19 INFO - warning: no files found matching '*.txt' 10:28:19 INFO - no previously-included directories found matching 'build' 10:28:19 INFO - no previously-included directories found matching 'dist' 10:28:19 INFO - no previously-included directories found matching '.git*' 10:28:19 INFO - Successfully installed jsonschema functools32 10:28:19 INFO - Cleaning up... 10:28:19 INFO - Return code: 0 10:28:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:28:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:19 INFO - 'HOME': '/Users/cltbld', 10:28:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:19 INFO - 'LOGNAME': 'cltbld', 10:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:19 INFO - 'MOZ_NO_REMOTE': '1', 10:28:19 INFO - 'NO_EM_RESTART': '1', 10:28:19 INFO - 'PAGER': '/bin/cat', 10:28:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:19 INFO - 'PWD': '/builds/slave/test', 10:28:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:19 INFO - 'SHELL': '/bin/bash', 10:28:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:19 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:19 INFO - 'USER': 'cltbld', 10:28:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:19 INFO - 'XPC_FLAGS': '0x0', 10:28:19 INFO - 'XPC_SERVICE_NAME': '0', 10:28:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:28:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:28:22 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:22 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:22 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:22 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:22 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:22 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:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:28:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:28:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:28:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:28:23 INFO - Downloading docopt-0.6.1.tar.gz 10:28:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:28:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:28:23 INFO - Running setup.py install for blobuploader 10:28:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:28:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:28:24 INFO - Running setup.py install for requests 10:28:24 INFO - Running setup.py install for docopt 10:28:24 INFO - Successfully installed blobuploader requests docopt 10:28:24 INFO - Cleaning up... 10:28:24 INFO - Return code: 0 10:28:24 INFO - Installing None 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', '--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 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:24 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:24 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:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:24 INFO - 'HOME': '/Users/cltbld', 10:28:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:24 INFO - 'LOGNAME': 'cltbld', 10:28:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:24 INFO - 'MOZ_NO_REMOTE': '1', 10:28:24 INFO - 'NO_EM_RESTART': '1', 10:28:24 INFO - 'PAGER': '/bin/cat', 10:28:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:24 INFO - 'PWD': '/builds/slave/test', 10:28:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:24 INFO - 'SHELL': '/bin/bash', 10:28:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:24 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:24 INFO - 'USER': 'cltbld', 10:28:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:24 INFO - 'XPC_FLAGS': '0x0', 10:28:24 INFO - 'XPC_SERVICE_NAME': '0', 10:28:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-k70vHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-7LC0eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-xOVO7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-euLo2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-kiG7xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-sY8B4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-QNOWtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Adh5Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-rsZ8Hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:25 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Zxzw2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-i1yPUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-axxK4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1RNYBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-mnW2Aw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-IFgREz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-bA98wE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:26 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-yhWQNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:28:26 INFO - Running setup.py install for manifestparser 10:28:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:28:26 INFO - Running setup.py install for mozcrash 10:28:27 INFO - Running setup.py install for mozdebug 10:28:27 INFO - Running setup.py install for mozdevice 10:28:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Running setup.py install for mozfile 10:28:27 INFO - Running setup.py install for mozhttpd 10:28:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Running setup.py install for mozinfo 10:28:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Running setup.py install for mozInstall 10:28:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:28:27 INFO - Running setup.py install for mozleak 10:28:28 INFO - Running setup.py install for mozlog 10:28:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:28:28 INFO - Running setup.py install for moznetwork 10:28:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:28:28 INFO - Running setup.py install for mozprocess 10:28:28 INFO - Running setup.py install for mozprofile 10:28:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:28:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:28:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:28:28 INFO - Running setup.py install for mozrunner 10:28:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:28:28 INFO - Running setup.py install for mozscreenshot 10:28:29 INFO - Running setup.py install for moztest 10:28:29 INFO - Running setup.py install for mozversion 10:28:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:28:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:28:29 INFO - Cleaning up... 10:28:29 INFO - Return code: 0 10:28:29 INFO - Installing None 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', '-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 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:29 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:29 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:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:29 INFO - 'HOME': '/Users/cltbld', 10:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:29 INFO - 'LOGNAME': 'cltbld', 10:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:29 INFO - 'MOZ_NO_REMOTE': '1', 10:28:29 INFO - 'NO_EM_RESTART': '1', 10:28:29 INFO - 'PAGER': '/bin/cat', 10:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:29 INFO - 'PWD': '/builds/slave/test', 10:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:29 INFO - 'SHELL': '/bin/bash', 10:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:29 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:29 INFO - 'USER': 'cltbld', 10:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:29 INFO - 'XPC_FLAGS': '0x0', 10:28:29 INFO - 'XPC_SERVICE_NAME': '0', 10:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:28:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-QefjCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:28:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:28:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-1gWQxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:28:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:28:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-SK93SP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:28:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:28:29 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-KbA9Yl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-TEwmtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-VVtFeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-W6fWFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-pVCvJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-IsEj7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-Xfbcud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-_2ZWF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-RmuNof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:28:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-LnnFDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:28:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:28:30 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-3rXRtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:28:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:31 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-ubsfZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:28:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:28:31 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-LQO18X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:28:31 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:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:28:31 INFO - Running setup.py (path:/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/pip-JzAUeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:28:31 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:31 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:31 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:31 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:31 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:31 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:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 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:33 INFO - Downloading blessings-1.6.tar.gz 10:28:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:28:33 INFO - Installing collected packages: blessings 10:28:33 INFO - Running setup.py install for blessings 10:28:34 INFO - Successfully installed blessings 10:28:34 INFO - Cleaning up... 10:28:34 INFO - Return code: 0 10:28:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:28:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:34 INFO - Reading from file tmpfile_stdout 10:28:34 INFO - Current package versions: 10:28:34 INFO - blessings == 1.6 10:28:34 INFO - blobuploader == 1.2.4 10:28:34 INFO - docopt == 0.6.1 10:28:34 INFO - functools32 == 3.2.3-2 10:28:34 INFO - jsonschema == 2.5.1 10:28:34 INFO - manifestparser == 1.1 10:28:34 INFO - mozInstall == 1.12 10:28:34 INFO - mozcrash == 0.17 10:28:34 INFO - mozdebug == 0.1 10:28:34 INFO - mozdevice == 0.48 10:28:34 INFO - mozfile == 1.2 10:28:34 INFO - mozhttpd == 0.7 10:28:34 INFO - mozinfo == 0.9 10:28:34 INFO - mozleak == 0.1 10:28:34 INFO - mozlog == 3.2 10:28:34 INFO - moznetwork == 0.27 10:28:34 INFO - mozprocess == 0.22 10:28:34 INFO - mozprofile == 0.28 10:28:34 INFO - mozrunner == 6.11 10:28:34 INFO - mozscreenshot == 0.1 10:28:34 INFO - mozsystemmonitor == 0.3 10:28:34 INFO - moztest == 0.7 10:28:34 INFO - mozversion == 1.4 10:28:34 INFO - psutil == 3.1.1 10:28:34 INFO - requests == 1.2.3 10:28:34 INFO - wsgiref == 0.1.2 10:28:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:34 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 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:34 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:34 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:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:34 INFO - 'HOME': '/Users/cltbld', 10:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:34 INFO - 'LOGNAME': 'cltbld', 10:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:34 INFO - 'MOZ_NO_REMOTE': '1', 10:28:34 INFO - 'NO_EM_RESTART': '1', 10:28:34 INFO - 'PAGER': '/bin/cat', 10:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:34 INFO - 'PWD': '/builds/slave/test', 10:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:34 INFO - 'SHELL': '/bin/bash', 10:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:34 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:34 INFO - 'USER': 'cltbld', 10:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:34 INFO - 'XPC_FLAGS': '0x0', 10:28:34 INFO - 'XPC_SERVICE_NAME': '0', 10:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 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:34 INFO - Cleaning up... 10:28:34 INFO - Return code: 0 10:28:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:28:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:28:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:28:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:28:34 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 0x105a2ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ac3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3e0da96b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 10:28:34 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:34 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:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:28:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:28:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:28:34 INFO - 'HOME': '/Users/cltbld', 10:28:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:28:34 INFO - 'LOGNAME': 'cltbld', 10:28:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:28:34 INFO - 'MOZ_NO_REMOTE': '1', 10:28:34 INFO - 'NO_EM_RESTART': '1', 10:28:34 INFO - 'PAGER': '/bin/cat', 10:28:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:28:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:28:34 INFO - 'PWD': '/builds/slave/test', 10:28:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:28:34 INFO - 'SHELL': '/bin/bash', 10:28:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:28:34 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:28:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:28:34 INFO - 'USER': 'cltbld', 10:28:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:28:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:28:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:28:34 INFO - 'XPC_FLAGS': '0x0', 10:28:34 INFO - 'XPC_SERVICE_NAME': '0', 10:28:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:28:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:28:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:28:35 INFO - Cleaning up... 10:28:35 INFO - Return code: 0 10:28:35 INFO - Running post-action listener: _resource_record_post_action 10:28:35 INFO - Running post-action listener: _start_resource_monitoring 10:28:35 INFO - Starting resource monitoring. 10:28:35 INFO - ##### 10:28:35 INFO - ##### Finished create-virtualenv step (success) 10:28:35 INFO - ##### 10:28:35 INFO - ##### 10:28:35 INFO - ##### Running install step. 10:28:35 INFO - ##### 10:28:35 INFO - Running pre-action listener: _resource_record_pre_action 10:28:35 INFO - Running main action method: install 10:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:28:35 INFO - Reading from file tmpfile_stdout 10:28:35 INFO - Detecting whether we're running mozinstall >=1.0... 10:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:28:35 INFO - Reading from file tmpfile_stdout 10:28:35 INFO - Output received: 10:28:35 INFO - Usage: mozinstall [options] installer 10:28:35 INFO - Options: 10:28:35 INFO - -h, --help show this help message and exit 10:28:35 INFO - -d DEST, --destination=DEST 10:28:35 INFO - Directory to install application into. [default: 10:28:35 INFO - "/builds/slave/test"] 10:28:35 INFO - --app=APP Application being installed. [default: firefox] 10:28:35 INFO - mkdir: /builds/slave/test/build/application 10:28:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:28:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:29:09 INFO - Reading from file tmpfile_stdout 10:29:09 INFO - Output received: 10:29:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:29:09 INFO - Running post-action listener: _resource_record_post_action 10:29:09 INFO - ##### 10:29:09 INFO - ##### Finished install step (success) 10:29:09 INFO - ##### 10:29:09 INFO - ##### 10:29:09 INFO - ##### Running run-tests step. 10:29:09 INFO - ##### 10:29:09 INFO - Running pre-action listener: _resource_record_pre_action 10:29:09 INFO - Running main action method: run_tests 10:29:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:29:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:29:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:29:09 INFO - 2016-08-01 10:29:09.674 screenresolution[1940:24666] starting screenresolution argv=screenresolution get 10:29:09 INFO - 2016-08-01 10:29:09.677 screenresolution[1940:24666] Display 0: 1600x1200x32@60 10:29:09 INFO - 2016-08-01 10:29:09.683 screenresolution[1941:24668] starting screenresolution argv=screenresolution list 10:29:09 INFO - Available Modes on Display 0 10:29:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:29:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:29:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:29:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:29:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:29:09 INFO - Intel Iris: 10:29:09 INFO - Chipset Model: Intel Iris 10:29:09 INFO - Type: GPU 10:29:09 INFO - Bus: Built-In 10:29:09 INFO - VRAM (Dynamic, Max): 1536 MB 10:29:09 INFO - Vendor: Intel (0x8086) 10:29:09 INFO - Device ID: 0x0a2e 10:29:09 INFO - Revision ID: 0x0009 10:29:09 INFO - Displays: 10:29:09 INFO - Display: 10:29:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:29:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:29:09 INFO - Display Serial Number: 1600x1200 60 10:29:09 INFO - Main Display: Yes 10:29:09 INFO - Mirror: Off 10:29:09 INFO - Online: Yes 10:29:09 INFO - Rotation: Supported 10:29:09 INFO - Return code: 0 10:29:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:29:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:29:09 INFO - Python 2.7.3 10:29:09 INFO - Return code: 0 10:29:09 INFO - grabbing minidump binary from tooltool 10:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:29:09 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/macosx64/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 0x105992d30>, '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 0x1056f7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10598ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:29:09 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:29:09 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/macosx64/releng.manifest -o -c /builds/tooltool_cache 10:29:09 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/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:29:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:29:10 INFO - Return code: 0 10:29:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:29:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:29:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:29:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:29:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0132 --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:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render', 10:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:29:10 INFO - 'HOME': '/Users/cltbld', 10:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:29:10 INFO - 'LOGNAME': 'cltbld', 10:29:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:29:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:29:10 INFO - 'MOZ_NO_REMOTE': '1', 10:29:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:29:10 INFO - 'NO_EM_RESTART': '1', 10:29:10 INFO - 'PAGER': '/bin/cat', 10:29:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:29:10 INFO - 'PWD': '/builds/slave/test', 10:29:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:29:10 INFO - 'SHELL': '/bin/bash', 10:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.STJcujnKxB/Listeners', 10:29:10 INFO - 'TMPDIR': '/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/', 10:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:29:10 INFO - 'USER': 'cltbld', 10:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:29:10 INFO - 'XPC_FLAGS': '0x0', 10:29:10 INFO - 'XPC_SERVICE_NAME': '0', 10:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:29:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0132', '--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:10 INFO - mozversion application_buildid: 20160801083949 10:29:10 INFO - mozversion application_changeset: 530dc1b58520ac87909eed9f22633712d5003830 10:29:10 INFO - mozversion application_display_name: Nightly 10:29:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:29:10 INFO - mozversion application_name: Firefox 10:29:10 INFO - mozversion application_remotingname: firefox 10:29:10 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 10:29:10 INFO - mozversion application_vendor: Mozilla 10:29:10 INFO - mozversion application_version: 50.0a1 10:29:10 INFO - mozversion platform_buildid: 20160801083949 10:29:10 INFO - mozversion platform_changeset: 530dc1b58520ac87909eed9f22633712d5003830 10:29:10 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 10:29:10 INFO - mozversion platform_version: 50.0a1 10:29:10 INFO - using testdate: 1470072550 10:29:10 INFO - actual date: 1470072550 10:29:10 INFO - starting webserver on 'localhost:55978' 10:29:10 INFO - SUITE-START | Running 2 tests 10:29:10 INFO - TEST-START | dromaeo_css 10:29:10 INFO - operating with platform_type : mac_ 10:29:10 INFO - Initialising browser for dromaeo_css test... 10:29:10 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpUvIBOD/profile http://localhost:55978/getInfo.html) 10:29:12 INFO - PROCESS | 1951 | __metrics Screen width/height:1600/1200 10:29:12 INFO - PROCESS | 1951 | colorDepth:24 10:29:12 INFO - PROCESS | 1951 | Browser inner width/height: 1024/689 10:29:12 INFO - PROCESS | 1951 | __metrics 10:29:12 INFO - PROCESS | 1951 | 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:12 INFO - PROCESS | 1951 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:29:13 INFO - TEST-INFO | 1951: exit 0 10:29:13 INFO - Browser initialized. 10:29:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:29:13 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpUvIBOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:29:25 INFO - PROCESS | 1953 | RSS: Main: 243539968 10:29:25 INFO - PROCESS | 1953 | 10:30:16 INFO - PROCESS | 1953 | 1470072616908 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:27 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:55978/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55978/tests/dromaeo/cssquery-ext.html) 10:32:28 INFO - PROCESS | 1953 | RSS: Main: 353570816 10:32:28 INFO - PROCESS | 1953 | 10:35:32 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:55978/tests/dromaeo/cssquery-ext.html (next: http://localhost:55978/tests/dromaeo/cssquery-jquery.html) 10:35:32 INFO - PROCESS | 1953 | RSS: Main: 378220544 10:35:32 INFO - PROCESS | 1953 | 10:38:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:55978/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55978/tests/dromaeo/cssquery-mootools.html) 10:38:35 INFO - PROCESS | 1953 | RSS: Main: 368439296 10:38:35 INFO - PROCESS | 1953 | 10:41:38 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:55978/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55978/tests/dromaeo/cssquery-prototype.html) 10:41:38 INFO - PROCESS | 1953 | RSS: Main: 364105728 10:41:38 INFO - PROCESS | 1953 | 10:44:42 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:55978/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55978/tests/dromaeo/cssquery-yui.html) 10:44:42 INFO - PROCESS | 1953 | RSS: Main: 332746752 10:44:42 INFO - PROCESS | 1953 | 10:47:45 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:55978/tests/dromaeo/cssquery-yui.html (next: http://localhost:55978/tests/dromaeo/cssquery-dojo.html) 10:47:46 INFO - PROCESS | 1953 | RSS: Main: 380805120 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | __start_tp_report 10:47:46 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 10:47:46 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 10:47:46 INFO - PROCESS | 1953 | |i|pagename|runs| 10:47:46 INFO - PROCESS | 1953 | |0;dojo.html;3324.833758312084;3327.7005069543734;3348.7488438367122;3366.966330336696;3397.1507123219194;5576.721163941807;5648.74580643871;5695.829125126243;5716.3140423149225;5721.056025755751;5606.775728970846;5721.056025755755;5746.683932383718;5752.7411266493;5782.913256301159;5003.749812509378;5068;5125.2312153176945;5146.639735218536;5234.26720259164;5228.529432351088;5257.842264732064;5265.078611243036;5272.604554658396;5304.867378315535;5091.592672586203;5101.387833460009;5140.974295128538;5163.1480805667015;5169.844904652867;5139.460356662534;5143.511366420222;5154.484551544853;5193.506616871391;5242.135047717122;5171.120909445366;5183.248428977815;5186.688798672092;5196.428392876781;5254.816081437131;5596.2165296858475;5628.127640215732;5776.133579962997;5797.304323481167;5862.9446699594055;6088.163069735877;6179.443850053517;6183.412575805291;6183.845403864894;6208.81373558794;5596.160575913605;5856.502197313233;6197.907031394533;6276.340984196685;6291.559590828644;5678.801241956594;5751.741171647286;5845.970770146165;5860.326062502824;5868.178455016301;6229.937700623026;6232.937670623326;6242.812715618538;6244.2506899171485;6254.781082662085;6135.7852475164045;6160.969195153995;6168.290646575611;6175.660338681326;6178.721957511832;6130.406094415395;6133.1413602095745;6154.969225153935;6183.721732522047;6332.4934005279465;6111.602745821508;6126.264848218153;6128.6016408934165;6143.293521245025;6183.505319574423;6199.690015499207;6208.410201030985;6213.099100630383;6233.75064997395;6240.937590624127;4393.253146965024;4934;4943.085529177114;4944.98627781304;4984.875378115504;4389.692721509464;4397.758123303185;4406.030673251944;4458.8439404620685;4498.145352383037;5703.258576385043;5754.367019627837;5779.306483222041;5786.739596718157;5829.125631155361;6160.907586386208;6230.688465576703;6252.624842509373;6261.373862613702;6269.247690277196;5513.365962914236;5658.264425624725;5700.714964251771;5753.798617048383;5785.566082543826;5408.810691625774;5421.4578542146255;5428.4028756836715;5451.155070964007;5472.315960504937;6252.249730032334;6254.499640028877;6256.186695729526;6260.311365749855;6273.215848019089;6113.932424433873;6125.571219981234;6192.164057852132;6202.5658203925295;6230.190075290183;6173.197484327009;6208.161898143693;6210.254769427517;6211.472024877936;6218.626882387071;6147.72335244924;6165.136880836597;6169.96915015422;6185.041318595625;6194.132821405097;6124.969375153096;6145.9692701536205;6166.290876549254;6194.008958566607;6217.160683307696;5976.671283079472;6111.194215906257;6112.1748563945075;6114.57197996136;6144.341027922346;6105.053716673922;6118.969405152946;6123.173371594778;6129.203203583684;6132.724027418688;5766.163906233489;5778.566607504538;5829.3004839417845;5852.707364631666;5854.648721076579;5947.31605865331;6000.699965001645;6007.459328660441;6047.66737829406;6088.111357418219;5866;5877.382874798084;5877.794277200277;5878.529717622494;5899.38056504078 10:47:46 INFO - PROCESS | 1953 | |1;ext.html;495.281841330071;522.3001178420915;526.9461077844311;537.2719964448173;560.7392562458456;29707.10878673638;40716.79641601792;42007.15985680284;42021.73934781954;44317.23303519205;43021.56978430215;43458.34812477815;43466.78266608671;43482;43485.782571087104;8667.263282620985;9497.620095196202;9676.661316853912;9704.126628603424;9756.756081097958;8682.826343473158;11685.59100431485;11924.880751192508;11950.521979120826;12134.150609457341;9334.71995840126;11826.704332391717;11898.881011189864;11917.761644767099;11917.821232681517;8662.740117796477;11544.249623774427;11729.589464368748;11815.995640370493;11831.585894493694;11704.47329870158;11779.352135632536;11798.351090690008;11805.645830625095;11807.586734464252;41072.38391424131;41377;41408.378874316906;41415.75752727423;41547.169056619;3496.35317466267;3518.102883764649;3546.4857595648486;3593.9820300898327;4315.978420107911;30877.691223087706;32078.518822217684;32393.838030809697;32408;32628.347433051207;3208.3262514871903;3294.456414691573;3353.9832300838584;3376.4260075787174;3382.7462940279333;440482;461588;463623;466524;467921;61307;61444;61720.38279617236;61769;61946.69026654838;64788;64892.18632043568;64917.67541162264;64993.70012599816;65088.34911650918;15774.580287774155;16216.594585135466;16412.507624771275;16432;16497.91751041261;11543;11822.34977076269;12560.685982850502;12706.04704647155;12875.871241287467;17774.46676599704;17790.199441025186;17808.732869006973;17830.5542361442;17869.285228590972;6031.668258245839;6584.5061620378665;6716.932830671631;6762.898556521656;6764.797056088325;854.7905763087958;1043.5773511727612;1068.6740544134113;1079.5250089960393;1079.9406032668278;29117.27206819804;29247.707522924924;30647.2338191547;31163.84418077895;31279.530807037914;1048.7063622185801;1074.0655629602295;1150.8791576884307;1162.4768854015558;1249.4689756853484;15854.841451585336;15992.680146397008;16054.832597599408;16177.4337898173;16292.51122466328;677997;678335;678521;679539;680841;57843.71078144582;59131;59391;59402.10896836551;59466;1169.2458364355114;1244.464880101565;1289.774289499334;1358.1307962903948;1402.845686974432;29987.25796377264;31949.68050319467;32124.19689507781;32550.34899302048;32719.836400817843;43492;51826;52346;52462.21306680479;52708.736456319006;502109.46835798223;567221;570742;570787;573514;34068;35390.46914296339;36557.26885462223;41372.37941430941;45111.54888451205;48484;48612.75693621509;49677.50322496729;50089;50169.49830501648;37130;39217.23522441554;41035.58964410318;41671;41951.58048419477;40218.1956360877;40597.79701101476;41093.383599246634;41212.793936030124;41661.37507937444;38979.610203897595;39031.82904512869;39964.2007159861;40046;42094;32984.67015329816;35328.47007294841;35607.10982225465;35786.284274313846;36653;25424.618630720925;25743.613845792705;25860.8706956464;26423.867880660473;26460.7353926466 10:47:46 INFO - PROCESS | 1953 | |2;jquery.html;362.2356827094831;381.191873228755;391.9666828319592;392.7368662995793;414.3742948148295;14993.333917223807;15579.298931548094;20864;20916.68624970623;21454.89272553639;20908.68636970443;21452.785472145275;21633.242836500725;21801.01895414706;21855.890720546377;5230.73846307685;5269.314989051418;5976.3724808895095;6176.907346389785;6178.25860896693;4231.280682284004;4502.0545685406105;6056.212692349988;6544.149260596116;6896.379325860671;6538.378854008862;6874.725010999554;6876;6876.553024053445;6884.311568843125;6712.0938673279215;6712.697928593225;6724.899126513106;6737.932620673829;6738.393544581011;5621.313605918208;5856.1508581255475;5869.7945571904775;5889.234399528077;5893.204417403681;26429.867850660623;26670;26720.465590688076;26754.796034178507;26835.731642683517;2029.6853987631941;2177.0421014753456;2296.357020034393;2671.5324818156746;2990.626171728534;5771.50942169916;5781.479666829963;5782.595218334718;7674.577898215596;10187.368777177417;1892.0634286028367;1905.3140869287045;1938.1278424708937;2024.3623258673617;2100.5588826346484;100148;120147;121102;121196.57606847814;121463;11624.709382265512;11650.126240531994;11661.35862527569;11677.007454366305;11784.528618855149;12274.38628068593;14437.639059023399;14555.908306877027;14575.125492470486;14684.26578671062;6944.583325000516;8482.10937851529;8549.914500854911;8590.699325523577;8645.524496152771;7685.885546595712;7746.30283274508;8422.873656895152;8554.529500877386;8572.699955501528;4543.068670922453;4564.360989461478;4573.49691533931;4584.518625544337;4628.976855115703;1642.9342826286816;1767.2754170790172;1788.9365334988804;1824.3455771851923;1910.8949007804426;836.9539675317916;924.9028851970446;968.5641461342283;981.7678813089527;1061.1563806773634;20525.589488210153;21528.468547328375;21983.068445012213;21988.450288742908;22012.707522033048;777.6383981448654;822.7079386817713;870.4081224767219;892.5448021508947;1003.1473247739509;11101.611443599435;11344.376059316652;11444;11462.942685286687;11492.482838272297;593400;603325;611696;613053;613985;101120;119699;121345.78654213522;124478;126345.36827315805;924.8751418558409;936.2743873498093;950.6577632052456;972.2125078686287;972.4214092614883;18883.58373122049;19130.904345478182;19141.808581914003;19205.80794192096;19207.135678894203;51720;52089.739551302;52519.73740131275;52741;52857.7357113212;75557;78348.60825695835;80142;82622;84256;8075.919240807517;8113;8115.675372985251;8421.4947103174;8445.619947102517;7835.725749598964;12900.967922565984;12983.675408114872;13170.341482925623;13487;11137.498812553293;11156.776864462827;11209.495572699085;11315.207935444769;11370.488328025423;9094;11222.775544489228;11393.088552915913;11465.598704045318;11612.012978896888;8820.823583528421;11791.29252244868;11834.704132396759;11905.642830715093;11933.343666098448;7128.895021271711;7424.554526728413;7499.287567681062;8301.169883011651;8571.142885711379;8173.100958894635;10258.846117308098;11344.20590558653;11512.654620361403;11583.942080289882 10:47:46 INFO - PROCESS | 1953 | |3;mootools.html;1531.2420351925791;1550.2326348457511;1762.4272111563746;1879.5489082620159;1932.5555122321866;8464.15358464154;8753.606087726052;8880.555972201397;8885.689000884962;8904.554772261385;7699.576523291216;8042.557659328734;8051.91948080519;8159.592020398971;8162.183781621835;2148.4843637526997;2277.6811246425514;2360.7639236076343;2372.5610762008996;2372.5847976604027;1996.3112726109468;2378.3340664613934;2402.9879850600723;2404.89177986991;2407.879606019701;2120.8833514156713;2387.1525608409024;2387.641853721947;2388.940276493093;2389.7490763469846;2154.34292540775;2173.5978843913927;2176.2383165891893;2177.9564408711894;2270.761570035139;2372.0630351011255;2406.2660888429023;2407.4222186675247;2411.9758802411925;2421.9515609687705;8681.782955426102;8760.992485864144;8762;8764.298856091498;8772;5170.793168273302;5371.301730775013;5378.435264297232;5378.46215378463;5385.676859388449;3594;3626.6192049834654;3652.3790955537625;3723.832427540767;3731.160488890005;1088.700607332982;1094.4254266510065;1095.370162156755;1108.384846410242;1113.6770336602376;9656.468894210815;11283.153763467773;11477.139214558858;11521.07831373488;11540.711482213012;4599.264117741145;4611.469680986663;4801.087793319258;4806.423229212517;4807.086653535817;9933;9936.950315248378;9942.105210531086;9956.253281003954;9963.900360996442;5318.680879147263;5319.962607291541;5320.494553017457;5326.334208223972;5334.813281535127;4122.237386083584;4372.846950356786;4681.461631912305;4800.5199480051715;4860.979194369152;3707.94438083429;3943.7042221832903;3978.522577290744;4052.696047796427;4063.89840253996;1097.742030622803;1106.2422240765102;1258.1256027061104;1296.8911580598453;1306.758249723804;841.9031811341774;904.7783293093235;910.3718434280457;936.7143021378545;980.2109302011949;4812;5971.044632858809;6000.716503463159;6024.759009639565;6035.456808887221;905.3843386497246;952.476138124029;984.2863923655435;992.1963209800085;1002.3785253142952;4021.7184797063924;4036.1725846201457;4060.4924384451942;4099;4105.4662893823615;8625;10575.947120264504;10605.25763196569;10661.307015043998;10685.412302323446;10605.681829545127;10606.310589811637;10620.628278010232;10625;10636.202284828669;7710.383169346439;8118.269355757892;8128.227818357246;8146.266835984789;8196.262336389753;5917.467427931335;5975.133605627247;6112.17485639433;6123.785667501616;6137.447629713347;9871.555779989774;9919.008099190023;10079;10131.7467063324;10136.44249566281;7750.457467977188;9630.374025688308;10123.088921997056;10175.49122543855;10185.115753585611;6938.826529336807;7163.032990546418;7459.142198647225;7629.54222746637;7657.310842024244;7966.123726389977;8237.629306681094;8243.340532757486;8347.95826020866;8350.87473687883;6899.7235511430545;7062.788116356517;7270.745523906638;7452.515586486861;7567.167611562613;6243.937560624336;7350.595717235603;7358.22738612438;7496;7520.887186692314;6773.221079575715;6972.1981972071835;6978.860422791414;6981.895271570829;6997.090378250795;4995.47547507521;5029.421616514148;5045.470225626256;5069.847904562869;5154.5103215194495;4999.200127979506;5053.772580233825;5075.974620126875;5244.344456942882;5275.208718692227 10:47:46 INFO - PROCESS | 1953 | |4;prototype.html;253.34636637475293;262.447547911646;289.4038281140851;301.48446157071413;303.8526314737352;4370.798030541602;5110.974445127778;5333.973330133344;5346.492083252089;5351.598630102739;4056.7768772717563;4494.876280929768;5155.072087024343;5216.374035115791;5227.398849132351;3316.3864685033227;4030.919381612366;4061.1521757600294;4061.8984525386804;4066.2883995300854;3097.272141046852;3834.827432765518;4030.637242648161;4039.6768258539246;4095.344744840826;3356.7482438817065;4019.3970904364287;4025.81883815229;4044.9191016179657;4062.573429789874;3572.3034008368377;3761.6082049641536;4041.818118184689;4044.635982761536;4053.412255222976;3559.1458050068054;3573.392523271024;3578.6779189873037;3580.427131658948;3595.658412450813;4835.709857408567;5075.492450754932;5075.593952483792;5210.66130701507;5223.843284701465;3850.3261929162286;3922.411638254256;4158.209940111369;4284.100338928797;4555.840545580889;4549.818007279705;5167.560757335631;5393.514583687448;5422.535915302846;5471.562275017989;3750.456183853353;3755.3052685253315;3761.4169803680475;3761.9278505625766;3777.941022142939;5166.948330516722;5287.757377016398;5634.577406694473;5655.3779084300695;5662.886742265173;3635.581908080552;3808.733388662767;3818.16000479894;3823.4073718573663;3828.904277393032;3377.324535092991;3651.1784848408897;3660.9200285915717;3680.7239457040296;3930.292547341506;3927.3323534999117;4499.842505512292;4520.254158063948;4524.253498172765;4543.363929049936;5564.944350556523;5602.467765562265;5644.379118296984;5663.461971112738;5692.971535142297;1048.8374301983206;1244.2534479312521;1285.7107150890974;1324.3908650989094;1327.2766342343252;792.3740245206222;806.9798255043671;818.6438899078801;821.4783612406166;823.1932705948085;4238.3430568261965;4306.5022287073425;4310.482742070909;4321.120312664001;4361.0841723237845;4677.041206552649;4721.504242054535;4773.880652983634;4803.495632958489;4853.4418541868135;3382.919504504761;3643.2531331077594;3792.6776224020714;4101.589841015934;4444.8444304449185;2033.3086750504604;2087.9038504784808;2439.2071827206987;2441.9145329913367;2469.1111199967995;4669.766511674403;4797.4482934462985;4815.22956326986;4840.975795121002;4895.8666453469805;4132.958670413317;4401.559844015637;4690.100509293741;4790.856274311776;4800.255960326155;3946.9013274668364;4160.399750156153;4754.667173297836;4780.705261474512;4925.802967881388;4161.875143745692;4214.494260688614;4678.953210467852;4821.590164836029;4823.347159062431;3760.3795373763023;4335.132973405269;4464.665150113689;4701.271302948048;4779;4293.91412171761;4722.5513576210205;4902.8774280643265;4919.2129259318335;4945.530174633404;2912.6504819421807;3140.811551306929;3453.240287136826;3703.79629120401;3743.6256374362347;4685.4143232095985;5552.33371995347;5563.970665426909;5574.609777315549;5602.887942241214;4398.450193725785;4827.468978412442;5093.159628661229;5507.972460137674;5509.779608815603;4750.7862146202815;5122.718250496258;5498.45015498447;5500.339959204761;5531.917021244765;4433.445819272591;5106;5407.810726624707;5421;5434.043744252145;4591.403117594691;5511.972440137773;5565.4991050804;5575.7490912909825;5633.8309850704545;4905.737684439808;5073.792900088326;5148.897022059463;5317.787288508416;5452.890942181055 10:47:46 INFO - PROCESS | 1953 | |5;yui.html;723.2731105239235;732.6373445144658;764.8164440534266;782.6517199846068;849.745076477057;14962.32669529871;15593.376264949402;16284.104374259427;16314.673706525891;16341;14602.634934126652;14789.260536973163;14799.92600037001;14802.925985370084;14826.406943722239;663.7046514301138;688.934551217636;832.7210384521162;839.630562552475;846.4286606540592;848.8429640516524;858.026140330726;860.101194252005;861.5218553702692;864.127231496187;916.7891384981458;918.2699753695828;918.7243826851951;920.1994264989469;920.5443305563755;707.3987110955698;863.3783675753448;910.7313342563959;911.6581282019242;916.1388295002677;681.8636272745421;682.8327059870314;683.4464084091852;683.9076724642209;684.4353408438059;14720.263986800725;14751.557453276419;14763;14766.852331476655;14798.112113273239;13523.526676566273;13589.796153057712;13599.796003059962;13738.931305343509;13901.860981390259;10538.841917371246;12530.03673915204;12869.227846329157;12960.805587916095;13253.360744902719;4573.291139873291;4606.930896036562;4610.67725259232;4782;4790.281457781326;110895;112061;120634;121750;122284;10836.349819010884;10881.727956801144;10888.727781805359;11018.944905275423;11175.161862860317;21154;21182;21183.470413239793;21185.682214766483;21208.78791212099;7195.352418282275;7372;7456.40348772097;7550.584717840462;7720.343770779435;4327.588879056548;4387.670924680661;4453.866384008485;4454.910901781946;4562.452505699337;3365.764396492271;3477.5826900772067;3480.965190348064;3483.233688588557;3483.4252348362743;633.5691729623808;646.0857886091222;648.176815444383;662.1855118204635;664.6211659354218;529.1665626638061;568.3208565763955;621.2917274307293;638.5913015669975;640.8186582548906;8558.272546833465;8639.175667880105;8855.141116993782;8895.28837692983;9029.013617004248;585.3034888482692;600.1537831657342;601.8314871835893;612.791650838717;650.4211251985737;4240.766757828349;4354.586314300136;4386.627136693417;4433.955660443419;4524.615407690318;129424;131399;133428;146943;158368.62447063305;115482;116028.0136077485;117977;118209.40895295641;118360.40819795846;81018;98242;109111.45444272728;112335.87664123418;118744;7954.772663654186;9744.17174540172;10021.599136034478;10087.142592879687;10126.645567405105;56802.431975681364;60238.69880650569;61279;61982.69008654928;63752.68123659352;70667.64666176637;85944;86836.56581717051;93260;94478.52760736152;13438.328083595976;13607.455701772215;13840;13926.442942282196;14079.0848594841;13567.38946747379;14544.320218655028;15110.697786044437;15358.462453814063;15556.455524056604;13905.72188556203;13906;14057.507987220399;14063.859361406256;14677;14102.36539355752;14279.928600356932;14283.500077497238;14745.778813318024;14883.702325953203;13611.455541778218;13728.176309421468;14225.430982760574;14268.714625707635;14357.066790658573;11450.198486105892;11565.363904985306;11687;11718.121140914636;11813;10773.730656733644;10905.890941090487;11481.311121332747;11627.360495172847;11675.416229188677 10:47:46 INFO - PROCESS | 1953 | __end_tp_report 10:47:46 INFO - PROCESS | 1953 | __start_cc_report 10:47:46 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,1181 10:47:46 INFO - PROCESS | 1953 | __end_cc_report 10:47:46 INFO - PROCESS | 1953 | __startTimestamp1470073666199__endTimestamp 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | ------- Summary: start ------- 10:47:46 INFO - PROCESS | 1953 | Number of tests: 6 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | [#0] dojo.html Cycles:165 Average:5716.09 Median:5868.18 stddev:630.87 (10.8%) stddev-sans-first:604.27 10:47:46 INFO - PROCESS | 1953 | Values: 3324.8 3327.7 3348.7 3367.0 3397.2 5576.7 5648.7 5695.8 5716.3 5721.1 5606.8 5721.1 5746.7 5752.7 5782.9 5003.7 5068.0 5125.2 5146.6 5234.3 5228.5 5257.8 5265.1 5272.6 5304.9 5091.6 5101.4 5141.0 5163.1 5169.8 5139.5 5143.5 5154.5 5193.5 5242.1 5171.1 5183.2 5186.7 5196.4 5254.8 5596.2 5628.1 5776.1 5797.3 5862.9 6088.2 6179.4 6183.4 6183.8 6208.8 5596.2 5856.5 6197.9 6276.3 6291.6 5678.8 5751.7 5846.0 5860.3 5868.2 6229.9 6232.9 6242.8 6244.3 6254.8 6135.8 6161.0 6168.3 6175.7 6178.7 6130.4 6133.1 6155.0 6183.7 6332.5 6111.6 6126.3 6128.6 6143.3 6183.5 6199.7 6208.4 6213.1 6233.8 6240.9 4393.3 4934.0 4943.1 4945.0 4984.9 4389.7 4397.8 4406.0 4458.8 4498.1 5703.3 5754.4 5779.3 5786.7 5829.1 6160.9 6230.7 6252.6 6261.4 6269.2 5513.4 5658.3 5700.7 5753.8 5785.6 5408.8 5421.5 5428.4 5451.2 5472.3 6252.2 6254.5 6256.2 6260.3 6273.2 6113.9 6125.6 6192.2 6202.6 6230.2 6173.2 6208.2 6210.3 6211.5 6218.6 6147.7 6165.1 6170.0 6185.0 6194.1 6125.0 6146.0 6166.3 6194.0 6217.2 5976.7 6111.2 6112.2 6114.6 6144.3 6105.1 6119.0 6123.2 6129.2 6132.7 5766.2 5778.6 5829.3 5852.7 5854.6 5947.3 6000.7 6007.5 6047.7 6088.1 5866.0 5877.4 5877.8 5878.5 5899.4 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | [#1] ext.html Cycles:180 Average:71007.10 Median:39005.72 stddev:152891.86 (392.0%) stddev-sans-first:153229.10 10:47:46 INFO - PROCESS | 1953 | Values: 495.3 522.3 526.9 537.3 560.7 29707.1 40716.8 42007.2 42021.7 44317.2 43021.6 43458.3 43466.8 43482.0 43485.8 8667.3 9497.6 9676.7 9704.1 9756.8 8682.8 11685.6 11924.9 11950.5 12134.2 9334.7 11826.7 11898.9 11917.8 11917.8 8662.7 11544.2 11729.6 11816.0 11831.6 11704.5 11779.4 11798.4 11805.6 11807.6 41072.4 41377.0 41408.4 41415.8 41547.2 3496.4 3518.1 3546.5 3594.0 4316.0 30877.7 32078.5 32393.8 32408.0 32628.3 3208.3 3294.5 3354.0 3376.4 3382.7 440482.0 461588.0 463623.0 466524.0 467921.0 61307.0 61444.0 61720.4 61769.0 61946.7 64788.0 64892.2 64917.7 64993.7 65088.3 15774.6 16216.6 16412.5 16432.0 16497.9 11543.0 11822.3 12560.7 12706.0 12875.9 17774.5 17790.2 17808.7 17830.6 17869.3 6031.7 6584.5 6716.9 6762.9 6764.8 854.8 1043.6 1068.7 1079.5 1079.9 29117.3 29247.7 30647.2 31163.8 31279.5 1048.7 1074.1 1150.9 1162.5 1249.5 15854.8 15992.7 16054.8 16177.4 16292.5 677997.0 678335.0 678521.0 679539.0 680841.0 57843.7 59131.0 59391.0 59402.1 59466.0 1169.2 1244.5 1289.8 1358.1 1402.8 29987.3 31949.7 32124.2 32550.3 32719.8 43492.0 51826.0 52346.0 52462.2 52708.7 502109.5 567221.0 570742.0 570787.0 573514.0 34068.0 35390.5 36557.3 41372.4 45111.5 48484.0 48612.8 49677.5 50089.0 50169.5 37130.0 39217.2 41035.6 41671.0 41951.6 40218.2 40597.8 41093.4 41212.8 41661.4 38979.6 39031.8 39964.2 40046.0 42094.0 32984.7 35328.5 35607.1 35786.3 36653.0 25424.6 25743.6 25860.9 26423.9 26460.7 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | [#2] jquery.html Cycles:180 Average:35006.50 Median:386.58 stddev:101051.67 (26140.0%) stddev-sans-first:101301.66 10:47:46 INFO - PROCESS | 1953 | Values: 362.2 381.2 392.0 392.7 414.4 14993.3 15579.3 20864.0 20916.7 21454.9 20908.7 21452.8 21633.2 21801.0 21855.9 5230.7 5269.3 5976.4 6176.9 6178.3 4231.3 4502.1 6056.2 6544.1 6896.4 6538.4 6874.7 6876.0 6876.6 6884.3 6712.1 6712.7 6724.9 6737.9 6738.4 5621.3 5856.2 5869.8 5889.2 5893.2 26429.9 26670.0 26720.5 26754.8 26835.7 2029.7 2177.0 2296.4 2671.5 2990.6 5771.5 5781.5 5782.6 7674.6 10187.4 1892.1 1905.3 1938.1 2024.4 2100.6 100148.0 120147.0 121102.0 121196.6 121463.0 11624.7 11650.1 11661.4 11677.0 11784.5 12274.4 14437.6 14555.9 14575.1 14684.3 6944.6 8482.1 8549.9 8590.7 8645.5 7685.9 7746.3 8422.9 8554.5 8572.7 4543.1 4564.4 4573.5 4584.5 4629.0 1642.9 1767.3 1788.9 1824.3 1910.9 837.0 924.9 968.6 981.8 1061.2 20525.6 21528.5 21983.1 21988.5 22012.7 777.6 822.7 870.4 892.5 1003.1 11101.6 11344.4 11444.0 11462.9 11492.5 593400.0 603325.0 611696.0 613053.0 613985.0 101120.0 119699.0 121345.8 124478.0 126345.4 924.9 936.3 950.7 972.2 972.4 18883.6 19130.9 19141.8 19205.8 19207.1 51720.0 52089.7 52519.7 52741.0 52857.7 75557.0 78348.6 80142.0 82622.0 84256.0 8075.9 8113.0 8115.7 8421.5 8445.6 7835.7 12901.0 12983.7 13170.3 13487.0 11137.5 11156.8 11209.5 11315.2 11370.5 9094.0 11222.8 11393.1 11465.6 11612.0 8820.8 11791.3 11834.7 11905.6 11933.3 7128.9 7424.6 7499.3 8301.2 8571.1 8173.1 10258.8 11344.2 11512.7 11583.9 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | [#3] mootools.html Cycles:180 Average:5644.70 Median:5061.81 stddev:3111.58 (61.5%) stddev-sans-first:3104.95 10:47:46 INFO - PROCESS | 1953 | Values: 1531.2 1550.2 1762.4 1879.5 1932.6 8464.2 8753.6 8880.6 8885.7 8904.6 7699.6 8042.6 8051.9 8159.6 8162.2 2148.5 2277.7 2360.8 2372.6 2372.6 1996.3 2378.3 2403.0 2404.9 2407.9 2120.9 2387.2 2387.6 2388.9 2389.7 2154.3 2173.6 2176.2 2178.0 2270.8 2372.1 2406.3 2407.4 2412.0 2422.0 8681.8 8761.0 8762.0 8764.3 8772.0 5170.8 5371.3 5378.4 5378.5 5385.7 3594.0 3626.6 3652.4 3723.8 3731.2 1088.7 1094.4 1095.4 1108.4 1113.7 9656.5 11283.2 11477.1 11521.1 11540.7 4599.3 4611.5 4801.1 4806.4 4807.1 9933.0 9937.0 9942.1 9956.3 9963.9 5318.7 5320.0 5320.5 5326.3 5334.8 4122.2 4372.8 4681.5 4800.5 4861.0 3707.9 3943.7 3978.5 4052.7 4063.9 1097.7 1106.2 1258.1 1296.9 1306.8 841.9 904.8 910.4 936.7 980.2 4812.0 5971.0 6000.7 6024.8 6035.5 905.4 952.5 984.3 992.2 1002.4 4021.7 4036.2 4060.5 4099.0 4105.5 8625.0 10575.9 10605.3 10661.3 10685.4 10605.7 10606.3 10620.6 10625.0 10636.2 7710.4 8118.3 8128.2 8146.3 8196.3 5917.5 5975.1 6112.2 6123.8 6137.4 9871.6 9919.0 10079.0 10131.7 10136.4 7750.5 9630.4 10123.1 10175.5 10185.1 6938.8 7163.0 7459.1 7629.5 7657.3 7966.1 8237.6 8243.3 8348.0 8350.9 6899.7 7062.8 7270.7 7452.5 7567.2 6243.9 7350.6 7358.2 7496.0 7520.9 6773.2 6972.2 6978.9 6981.9 6997.1 4995.5 5029.4 5045.5 5069.8 5154.5 4999.2 5053.8 5076.0 5244.3 5275.2 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | [#4] prototype.html Cycles:180 Average:4172.61 Median:4510.05 stddev:1280.45 (28.4%) stddev-sans-first:1249.79 10:47:46 INFO - PROCESS | 1953 | Values: 253.3 262.4 289.4 301.5 303.9 4370.8 5111.0 5334.0 5346.5 5351.6 4056.8 4494.9 5155.1 5216.4 5227.4 3316.4 4030.9 4061.2 4061.9 4066.3 3097.3 3834.8 4030.6 4039.7 4095.3 3356.7 4019.4 4025.8 4044.9 4062.6 3572.3 3761.6 4041.8 4044.6 4053.4 3559.1 3573.4 3578.7 3580.4 3595.7 4835.7 5075.5 5075.6 5210.7 5223.8 3850.3 3922.4 4158.2 4284.1 4555.8 4549.8 5167.6 5393.5 5422.5 5471.6 3750.5 3755.3 3761.4 3761.9 3777.9 5166.9 5287.8 5634.6 5655.4 5662.9 3635.6 3808.7 3818.2 3823.4 3828.9 3377.3 3651.2 3660.9 3680.7 3930.3 3927.3 4499.8 4520.3 4524.3 4543.4 5564.9 5602.5 5644.4 5663.5 5693.0 1048.8 1244.3 1285.7 1324.4 1327.3 792.4 807.0 818.6 821.5 823.2 4238.3 4306.5 4310.5 4321.1 4361.1 4677.0 4721.5 4773.9 4803.5 4853.4 3382.9 3643.3 3792.7 4101.6 4444.8 2033.3 2087.9 2439.2 2441.9 2469.1 4669.8 4797.4 4815.2 4841.0 4895.9 4133.0 4401.6 4690.1 4790.9 4800.3 3946.9 4160.4 4754.7 4780.7 4925.8 4161.9 4214.5 4679.0 4821.6 4823.3 3760.4 4335.1 4464.7 4701.3 4779.0 4293.9 4722.6 4902.9 4919.2 4945.5 2912.7 3140.8 3453.2 3703.8 3743.6 4685.4 5552.3 5564.0 5574.6 5602.9 4398.5 4827.5 5093.2 5508.0 5509.8 4750.8 5122.7 5498.5 5500.3 5531.9 4433.4 5106.0 5407.8 5421.0 5434.0 4591.4 5512.0 5565.5 5575.7 5633.8 4905.7 5073.8 5148.9 5317.8 5452.9 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - PROCESS | 1953 | [#5] yui.html Cycles:180 Average:24248.47 Median:12287.28 stddev:37917.54 (308.6%) stddev-sans-first:37982.77 10:47:46 INFO - PROCESS | 1953 | Values: 723.3 732.6 764.8 782.7 849.7 14962.3 15593.4 16284.1 16314.7 16341.0 14602.6 14789.3 14799.9 14802.9 14826.4 663.7 688.9 832.7 839.6 846.4 848.8 858.0 860.1 861.5 864.1 916.8 918.3 918.7 920.2 920.5 707.4 863.4 910.7 911.7 916.1 681.9 682.8 683.4 683.9 684.4 14720.3 14751.6 14763.0 14766.9 14798.1 13523.5 13589.8 13599.8 13738.9 13901.9 10538.8 12530.0 12869.2 12960.8 13253.4 4573.3 4606.9 4610.7 4782.0 4790.3 110895.0 112061.0 120634.0 121750.0 122284.0 10836.3 10881.7 10888.7 11018.9 11175.2 21154.0 21182.0 21183.5 21185.7 21208.8 7195.4 7372.0 7456.4 7550.6 7720.3 4327.6 4387.7 4453.9 4454.9 4562.5 3365.8 3477.6 3481.0 3483.2 3483.4 633.6 646.1 648.2 662.2 664.6 529.2 568.3 621.3 638.6 640.8 8558.3 8639.2 8855.1 8895.3 9029.0 585.3 600.2 601.8 612.8 650.4 4240.8 4354.6 4386.6 4434.0 4524.6 129424.0 131399.0 133428.0 146943.0 158368.6 115482.0 116028.0 117977.0 118209.4 118360.4 81018.0 98242.0 109111.5 112335.9 118744.0 7954.8 9744.2 10021.6 10087.1 10126.6 56802.4 60238.7 61279.0 61982.7 63752.7 70667.6 85944.0 86836.6 93260.0 94478.5 13438.3 13607.5 13840.0 13926.4 14079.1 13567.4 14544.3 15110.7 15358.5 15556.5 13905.7 13906.0 14057.5 14063.9 14677.0 14102.4 14279.9 14283.5 14745.8 14883.7 13611.5 13728.2 14225.4 14268.7 14357.1 11450.2 11565.4 11687.0 11718.1 11813.0 10773.7 10905.9 11481.3 11627.4 11675.4 10:47:46 INFO - PROCESS | 1953 | -------- Summary: end -------- 10:47:46 INFO - PROCESS | 1953 | 10:47:46 INFO - TEST-INFO | 1953: exit 0 10:47:46 INFO - TEST-OK | dromaeo_css | took 1116609ms 10:47:46 INFO - TEST-START | kraken 10:47:46 INFO - operating with platform_type : mac_ 10:47:46 INFO - Initialising browser for kraken test... 10:47:46 INFO - TEST-INFO | started process 1958 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpMS7Euw/profile http://localhost:55978/getInfo.html) 10:47:48 INFO - PROCESS | 1958 | __metrics Screen width/height:1600/1200 10:47:48 INFO - PROCESS | 1958 | colorDepth:24 10:47:48 INFO - PROCESS | 1958 | Browser inner width/height: 1024/689 10:47:48 INFO - PROCESS | 1958 | __metrics 10:47:49 INFO - PROCESS | 1958 | 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:49 INFO - PROCESS | 1958 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:49 INFO - TEST-INFO | 1958: exit 0 10:47:49 INFO - Browser initialized. 10:47:49 INFO - Running cycle 1/1 for kraken test... 10:47:49 INFO - TEST-INFO | started process 1959 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/tmpMS7Euw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:48:01 INFO - PROCESS | 1959 | RSS: Main: 243453952 10:48:01 INFO - PROCESS | 1959 | 10:48:04 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55978/tests/kraken/driver.html?testName=audio-beat-detection) 10:48:05 INFO - PROCESS | 1959 | RSS: Main: 294428672 10:48:05 INFO - PROCESS | 1959 | 10:48:07 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55978/tests/kraken/driver.html?testName=audio-dft) 10:48:08 INFO - PROCESS | 1959 | RSS: Main: 304320512 10:48:08 INFO - PROCESS | 1959 | 10:48:12 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55978/tests/kraken/driver.html?testName=audio-fft) 10:48:12 INFO - PROCESS | 1959 | RSS: Main: 386396160 10:48:12 INFO - PROCESS | 1959 | 10:48:14 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55978/tests/kraken/driver.html?testName=audio-oscillator) 10:48:15 INFO - PROCESS | 1959 | RSS: Main: 288288768 10:48:15 INFO - PROCESS | 1959 | 10:48:17 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55978/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:48:18 INFO - PROCESS | 1959 | RSS: Main: 292638720 10:48:18 INFO - PROCESS | 1959 | 10:48:20 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55978/tests/kraken/driver.html?testName=imaging-darkroom) 10:48:21 INFO - PROCESS | 1959 | RSS: Main: 330231808 10:48:21 INFO - PROCESS | 1959 | 10:48:24 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55978/tests/kraken/driver.html?testName=imaging-desaturate) 10:48:24 INFO - PROCESS | 1959 | RSS: Main: 331984896 10:48:24 INFO - PROCESS | 1959 | 10:48:27 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55978/tests/kraken/driver.html?testName=json-parse-financial) 10:48:28 INFO - PROCESS | 1959 | RSS: Main: 328450048 10:48:28 INFO - PROCESS | 1959 | 10:48:30 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55978/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:48:30 INFO - PROCESS | 1959 | RSS: Main: 311246848 10:48:30 INFO - PROCESS | 1959 | 10:48:32 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:48:33 INFO - PROCESS | 1959 | RSS: Main: 317964288 10:48:33 INFO - PROCESS | 1959 | 10:48:35 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:48:36 INFO - PROCESS | 1959 | RSS: Main: 323715072 10:48:36 INFO - PROCESS | 1959 | 10:48:39 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:48:39 INFO - PROCESS | 1959 | RSS: Main: 325062656 10:48:39 INFO - PROCESS | 1959 | 10:48:42 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:48:43 INFO - PROCESS | 1959 | RSS: Main: 325062656 10:48:43 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | Cycle 1(1): loaded http://localhost:55978/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55978/tests/kraken/driver.html?testName=ai-astar) 10:48:45 INFO - PROCESS | 1959 | RSS: Main: 368435200 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | __start_tp_report 10:48:45 INFO - PROCESS | 1959 | _x_x_mozilla_page_load 10:48:45 INFO - PROCESS | 1959 | _x_x_mozilla_page_load_details 10:48:45 INFO - PROCESS | 1959 | |i|pagename|runs| 10:48:45 INFO - PROCESS | 1959 | |0;ai-astar;100;112;112;111;114;112;112;113;112;113 10:48:45 INFO - PROCESS | 1959 | |1;audio-beat-detection;145;108;106;161;109;105;129;109;146;105 10:48:45 INFO - PROCESS | 1959 | |2;audio-dft;185;186;186;184;184;185;184;183;187;185 10:48:45 INFO - PROCESS | 1959 | |3;audio-fft;77;76;58;108;57;57;60;60;98;56 10:48:45 INFO - PROCESS | 1959 | |4;audio-oscillator;81;90;112;71;69;68;95;75;69;128 10:48:45 INFO - PROCESS | 1959 | |5;imaging-gaussian-blur;86;84;87;83;86;84;87;85;86;83 10:48:45 INFO - PROCESS | 1959 | |6;imaging-darkroom;93;93;94;94;111;148;114;94;93;92 10:48:45 INFO - PROCESS | 1959 | |7;imaging-desaturate;86;84;87;86;84;81;86;71;133;136 10:48:45 INFO - PROCESS | 1959 | |8;json-parse-financial;57;56;54;54;53;55;54;54;55;54 10:48:45 INFO - PROCESS | 1959 | |9;json-stringify-tinderbox;65;67;93;111;109;75;69;71;70;69 10:48:45 INFO - PROCESS | 1959 | |10;stanford-crypto-aes;86;86;82;84;84;85;85;86;88;101 10:48:45 INFO - PROCESS | 1959 | |11;stanford-crypto-ccm;140;150;130;144;152;147;145;135;168;153 10:48:45 INFO - PROCESS | 1959 | |12;stanford-crypto-pbkdf2;168;166;171;231;195;167;165;178;223;200 10:48:45 INFO - PROCESS | 1959 | |13;stanford-crypto-sha256-iterative;67;68;68;66;70;69;64;57;69;79 10:48:45 INFO - PROCESS | 1959 | __end_tp_report 10:48:45 INFO - PROCESS | 1959 | __start_cc_report 10:48:45 INFO - PROCESS | 1959 | _x_x_mozilla_cycle_collect,2006 10:48:45 INFO - PROCESS | 1959 | __end_cc_report 10:48:45 INFO - PROCESS | 1959 | __startTimestamp1470073725526__endTimestamp 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | ------- Summary: start ------- 10:48:45 INFO - PROCESS | 1959 | Number of tests: 14 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.98 (3.6%) stddev-sans-first:0.87 10:48:45 INFO - PROCESS | 1959 | Values: 100.0 112.0 112.0 111.0 114.0 112.0 112.0 113.0 112.0 113.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#1] audio-beat-detection Cycles:10 Average:122.30 Median:119.00 stddev:21.19 (17.8%) stddev-sans-first:20.83 10:48:45 INFO - PROCESS | 1959 | Values: 145.0 108.0 106.0 161.0 109.0 105.0 129.0 109.0 146.0 105.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.00 stddev:1.20 (0.6%) stddev-sans-first:1.27 10:48:45 INFO - PROCESS | 1959 | Values: 185.0 186.0 186.0 184.0 184.0 185.0 184.0 183.0 187.0 185.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#3] audio-fft Cycles:10 Average:70.70 Median:60.00 stddev:18.82 (31.4%) stddev-sans-first:19.82 10:48:45 INFO - PROCESS | 1959 | Values: 77.0 76.0 58.0 108.0 57.0 57.0 60.0 60.0 98.0 56.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:73.00 stddev:20.57 (28.2%) stddev-sans-first:21.75 10:48:45 INFO - PROCESS | 1959 | Values: 81.0 90.0 112.0 71.0 69.0 68.0 95.0 75.0 69.0 128.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 10:48:45 INFO - PROCESS | 1959 | Values: 86.0 84.0 87.0 83.0 86.0 84.0 87.0 85.0 86.0 83.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:17.86 (19.2%) stddev-sans-first:18.61 10:48:45 INFO - PROCESS | 1959 | Values: 93.0 93.0 94.0 94.0 111.0 148.0 114.0 94.0 93.0 92.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:85.00 stddev:22.16 (26.1%) stddev-sans-first:23.34 10:48:45 INFO - PROCESS | 1959 | Values: 86.0 84.0 87.0 86.0 84.0 81.0 86.0 71.0 133.0 136.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.17 (2.2%) stddev-sans-first:0.87 10:48:45 INFO - PROCESS | 1959 | Values: 57.0 56.0 54.0 54.0 53.0 55.0 54.0 54.0 55.0 54.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#9] json-stringify-tinderbox Cycles:10 Average:79.90 Median:69.50 stddev:17.68 (25.4%) stddev-sans-first:17.91 10:48:45 INFO - PROCESS | 1959 | Values: 65.0 67.0 93.0 111.0 109.0 75.0 69.0 71.0 70.0 69.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:85.50 stddev:5.27 (6.2%) stddev-sans-first:5.59 10:48:45 INFO - PROCESS | 1959 | Values: 86.0 86.0 82.0 84.0 84.0 85.0 85.0 86.0 88.0 101.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:148.50 stddev:10.55 (7.1%) stddev-sans-first:10.94 10:48:45 INFO - PROCESS | 1959 | Values: 140.0 150.0 130.0 144.0 152.0 147.0 145.0 135.0 168.0 153.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:186.50 stddev:24.69 (13.2%) stddev-sans-first:25.27 10:48:45 INFO - PROCESS | 1959 | Values: 168.0 166.0 171.0 231.0 195.0 167.0 165.0 178.0 223.0 200.0 10:48:45 INFO - PROCESS | 1959 | 10:48:45 INFO - PROCESS | 1959 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.50 stddev:5.46 (8.0%) stddev-sans-first:5.78 10:48:45 INFO - PROCESS | 1959 | Values: 67.0 68.0 68.0 66.0 70.0 69.0 64.0 57.0 69.0 79.0 10:48:45 INFO - PROCESS | 1959 | -------- Summary: end -------- 10:48:45 INFO - PROCESS | 1959 | 10:48:46 INFO - TEST-INFO | 1959: exit 0 10:48:46 INFO - TEST-OK | kraken | took 59674ms 10:48:46 INFO - SUITE-END | took 1176s 10:48:46 INFO - Completed test suite (00:19:36) 10:48:46 INFO - javascript benchmark 10:48:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3324.833758312084, 3327.7005069543734, 3348.7488438367122, 3366.966330336696, 3397.1507123219194, 5576.721163941807, 5648.74580643871, 5695.829125126243, 5716.3140423149225, 5721.056025755751, 5606.775728970846, 5721.056025755755, 5746.683932383718, 5752.7411266493, 5782.913256301159, 5003.749812509378, 5068.0, 5125.2312153176945, 5146.639735218536, 5234.26720259164, 5228.529432351088, 5257.842264732064, 5265.078611243036, 5272.604554658396, 5304.867378315535, 5091.592672586203, 5101.387833460009, 5140.974295128538, 5163.1480805667015, 5169.844904652867, 5139.460356662534, 5143.511366420222, 5154.484551544853, 5193.506616871391, 5242.135047717122, 5171.120909445366, 5183.248428977815, 5186.688798672092, 5196.428392876781, 5254.816081437131, 5596.2165296858475, 5628.127640215732, 5776.133579962997, 5797.304323481167, 5862.9446699594055, 6088.163069735877, 6179.443850053517, 6183.412575805291, 6183.845403864894, 6208.81373558794, 5596.160575913605, 5856.502197313233, 6197.907031394533, 6276.340984196685, 6291.559590828644, 5678.801241956594, 5751.741171647286, 5845.970770146165, 5860.326062502824, 5868.178455016301, 6229.937700623026, 6232.937670623326, 6242.812715618538, 6244.2506899171485, 6254.781082662085, 6135.7852475164045, 6160.969195153995, 6168.290646575611, 6175.660338681326, 6178.721957511832, 6130.406094415395, 6133.1413602095745, 6154.969225153935, 6183.721732522047, 6332.4934005279465, 6111.602745821508, 6126.264848218153, 6128.6016408934165, 6143.293521245025, 6183.505319574423, 6199.690015499207, 6208.410201030985, 6213.099100630383, 6233.75064997395, 6240.937590624127, 4393.253146965024, 4934.0, 4943.085529177114, 4944.98627781304, 4984.875378115504, 4389.692721509464, 4397.758123303185, 4406.030673251944, 4458.8439404620685, 4498.145352383037, 5703.258576385043, 5754.367019627837, 5779.306483222041, 5786.739596718157, 5829.125631155361, 6160.907586386208, 6230.688465576703, 6252.624842509373, 6261.373862613702, 6269.247690277196, 5513.365962914236, 5658.264425624725, 5700.714964251771, 5753.798617048383, 5785.566082543826, 5408.810691625774, 5421.4578542146255, 5428.4028756836715, 5451.155070964007, 5472.315960504937, 6252.249730032334, 6254.499640028877, 6256.186695729526, 6260.311365749855, 6273.215848019089, 6113.932424433873, 6125.571219981234, 6192.164057852132, 6202.5658203925295, 6230.190075290183, 6173.197484327009, 6208.161898143693, 6210.254769427517, 6211.472024877936, 6218.626882387071, 6147.72335244924, 6165.136880836597, 6169.96915015422, 6185.041318595625, 6194.132821405097, 6124.969375153096, 6145.9692701536205, 6166.290876549254, 6194.008958566607, 6217.160683307696, 5976.671283079472, 6111.194215906257, 6112.1748563945075, 6114.57197996136, 6144.341027922346, 6105.053716673922, 6118.969405152946, 6123.173371594778, 6129.203203583684, 6132.724027418688, 5766.163906233489, 5778.566607504538, 5829.3004839417845, 5852.707364631666, 5854.648721076579, 5947.31605865331, 6000.699965001645, 6007.459328660441, 6047.66737829406, 6088.111357418219, 5866.0, 5877.382874798084, 5877.794277200277, 5878.529717622494, 5899.38056504078], "value": 5675.303495076745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.281841330071, 522.3001178420915, 526.9461077844311, 537.2719964448173, 560.7392562458456, 29707.10878673638, 40716.79641601792, 42007.15985680284, 42021.73934781954, 44317.23303519205, 43021.56978430215, 43458.34812477815, 43466.78266608671, 43482.0, 43485.782571087104, 8667.263282620985, 9497.620095196202, 9676.661316853912, 9704.126628603424, 9756.756081097958, 8682.826343473158, 11685.59100431485, 11924.880751192508, 11950.521979120826, 12134.150609457341, 9334.71995840126, 11826.704332391717, 11898.881011189864, 11917.761644767099, 11917.821232681517, 8662.740117796477, 11544.249623774427, 11729.589464368748, 11815.995640370493, 11831.585894493694, 11704.47329870158, 11779.352135632536, 11798.351090690008, 11805.645830625095, 11807.586734464252, 41072.38391424131, 41377.0, 41408.378874316906, 41415.75752727423, 41547.169056619, 3496.35317466267, 3518.102883764649, 3546.4857595648486, 3593.9820300898327, 4315.978420107911, 30877.691223087706, 32078.518822217684, 32393.838030809697, 32408.0, 32628.347433051207, 3208.3262514871903, 3294.456414691573, 3353.9832300838584, 3376.4260075787174, 3382.7462940279333, 440482.0, 461588.0, 463623.0, 466524.0, 467921.0, 61307.0, 61444.0, 61720.38279617236, 61769.0, 61946.69026654838, 64788.0, 64892.18632043568, 64917.67541162264, 64993.70012599816, 65088.34911650918, 15774.580287774155, 16216.594585135466, 16412.507624771275, 16432.0, 16497.91751041261, 11543.0, 11822.34977076269, 12560.685982850502, 12706.04704647155, 12875.871241287467, 17774.46676599704, 17790.199441025186, 17808.732869006973, 17830.5542361442, 17869.285228590972, 6031.668258245839, 6584.5061620378665, 6716.932830671631, 6762.898556521656, 6764.797056088325, 854.7905763087958, 1043.5773511727612, 1068.6740544134113, 1079.5250089960393, 1079.9406032668278, 29117.27206819804, 29247.707522924924, 30647.2338191547, 31163.84418077895, 31279.530807037914, 1048.7063622185801, 1074.0655629602295, 1150.8791576884307, 1162.4768854015558, 1249.4689756853484, 15854.841451585336, 15992.680146397008, 16054.832597599408, 16177.4337898173, 16292.51122466328, 677997.0, 678335.0, 678521.0, 679539.0, 680841.0, 57843.71078144582, 59131.0, 59391.0, 59402.10896836551, 59466.0, 1169.2458364355114, 1244.464880101565, 1289.774289499334, 1358.1307962903948, 1402.845686974432, 29987.25796377264, 31949.68050319467, 32124.19689507781, 32550.34899302048, 32719.836400817843, 43492.0, 51826.0, 52346.0, 52462.21306680479, 52708.736456319006, 502109.46835798223, 567221.0, 570742.0, 570787.0, 573514.0, 34068.0, 35390.46914296339, 36557.26885462223, 41372.37941430941, 45111.54888451205, 48484.0, 48612.75693621509, 49677.50322496729, 50089.0, 50169.49830501648, 37130.0, 39217.23522441554, 41035.58964410318, 41671.0, 41951.58048419477, 40218.1956360877, 40597.79701101476, 41093.383599246634, 41212.793936030124, 41661.37507937444, 38979.610203897595, 39031.82904512869, 39964.2007159861, 40046.0, 42094.0, 32984.67015329816, 35328.47007294841, 35607.10982225465, 35786.284274313846, 36653.0, 25424.618630720925, 25743.613845792705, 25860.8706956464, 26423.867880660473, 26460.7353926466], "value": 20855.23357947662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.2356827094831, 381.191873228755, 391.9666828319592, 392.7368662995793, 414.3742948148295, 14993.333917223807, 15579.298931548094, 20864.0, 20916.68624970623, 21454.89272553639, 20908.68636970443, 21452.785472145275, 21633.242836500725, 21801.01895414706, 21855.890720546377, 5230.73846307685, 5269.314989051418, 5976.3724808895095, 6176.907346389785, 6178.25860896693, 4231.280682284004, 4502.0545685406105, 6056.212692349988, 6544.149260596116, 6896.379325860671, 6538.378854008862, 6874.725010999554, 6876.0, 6876.553024053445, 6884.311568843125, 6712.0938673279215, 6712.697928593225, 6724.899126513106, 6737.932620673829, 6738.393544581011, 5621.313605918208, 5856.1508581255475, 5869.7945571904775, 5889.234399528077, 5893.204417403681, 26429.867850660623, 26670.0, 26720.465590688076, 26754.796034178507, 26835.731642683517, 2029.6853987631941, 2177.0421014753456, 2296.357020034393, 2671.5324818156746, 2990.626171728534, 5771.50942169916, 5781.479666829963, 5782.595218334718, 7674.577898215596, 10187.368777177417, 1892.0634286028367, 1905.3140869287045, 1938.1278424708937, 2024.3623258673617, 2100.5588826346484, 100148.0, 120147.0, 121102.0, 121196.57606847814, 121463.0, 11624.709382265512, 11650.126240531994, 11661.35862527569, 11677.007454366305, 11784.528618855149, 12274.38628068593, 14437.639059023399, 14555.908306877027, 14575.125492470486, 14684.26578671062, 6944.583325000516, 8482.10937851529, 8549.914500854911, 8590.699325523577, 8645.524496152771, 7685.885546595712, 7746.30283274508, 8422.873656895152, 8554.529500877386, 8572.699955501528, 4543.068670922453, 4564.360989461478, 4573.49691533931, 4584.518625544337, 4628.976855115703, 1642.9342826286816, 1767.2754170790172, 1788.9365334988804, 1824.3455771851923, 1910.8949007804426, 836.9539675317916, 924.9028851970446, 968.5641461342283, 981.7678813089527, 1061.1563806773634, 20525.589488210153, 21528.468547328375, 21983.068445012213, 21988.450288742908, 22012.707522033048, 777.6383981448654, 822.7079386817713, 870.4081224767219, 892.5448021508947, 1003.1473247739509, 11101.611443599435, 11344.376059316652, 11444.0, 11462.942685286687, 11492.482838272297, 593400.0, 603325.0, 611696.0, 613053.0, 613985.0, 101120.0, 119699.0, 121345.78654213522, 124478.0, 126345.36827315805, 924.8751418558409, 936.2743873498093, 950.6577632052456, 972.2125078686287, 972.4214092614883, 18883.58373122049, 19130.904345478182, 19141.808581914003, 19205.80794192096, 19207.135678894203, 51720.0, 52089.739551302, 52519.73740131275, 52741.0, 52857.7357113212, 75557.0, 78348.60825695835, 80142.0, 82622.0, 84256.0, 8075.919240807517, 8113.0, 8115.675372985251, 8421.4947103174, 8445.619947102517, 7835.725749598964, 12900.967922565984, 12983.675408114872, 13170.341482925623, 13487.0, 11137.498812553293, 11156.776864462827, 11209.495572699085, 11315.207935444769, 11370.488328025423, 9094.0, 11222.775544489228, 11393.088552915913, 11465.598704045318, 11612.012978896888, 8820.823583528421, 11791.29252244868, 11834.704132396759, 11905.642830715093, 11933.343666098448, 7128.895021271711, 7424.554526728413, 7499.287567681062, 8301.169883011651, 8571.142885711379, 8173.100958894635, 10258.846117308098, 11344.20590558653, 11512.654620361403, 11583.942080289882], "value": 9516.663404051196, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1531.2420351925791, 1550.2326348457511, 1762.4272111563746, 1879.5489082620159, 1932.5555122321866, 8464.15358464154, 8753.606087726052, 8880.555972201397, 8885.689000884962, 8904.554772261385, 7699.576523291216, 8042.557659328734, 8051.91948080519, 8159.592020398971, 8162.183781621835, 2148.4843637526997, 2277.6811246425514, 2360.7639236076343, 2372.5610762008996, 2372.5847976604027, 1996.3112726109468, 2378.3340664613934, 2402.9879850600723, 2404.89177986991, 2407.879606019701, 2120.8833514156713, 2387.1525608409024, 2387.641853721947, 2388.940276493093, 2389.7490763469846, 2154.34292540775, 2173.5978843913927, 2176.2383165891893, 2177.9564408711894, 2270.761570035139, 2372.0630351011255, 2406.2660888429023, 2407.4222186675247, 2411.9758802411925, 2421.9515609687705, 8681.782955426102, 8760.992485864144, 8762.0, 8764.298856091498, 8772.0, 5170.793168273302, 5371.301730775013, 5378.435264297232, 5378.46215378463, 5385.676859388449, 3594.0, 3626.6192049834654, 3652.3790955537625, 3723.832427540767, 3731.160488890005, 1088.700607332982, 1094.4254266510065, 1095.370162156755, 1108.384846410242, 1113.6770336602376, 9656.468894210815, 11283.153763467773, 11477.139214558858, 11521.07831373488, 11540.711482213012, 4599.264117741145, 4611.469680986663, 4801.087793319258, 4806.423229212517, 4807.086653535817, 9933.0, 9936.950315248378, 9942.105210531086, 9956.253281003954, 9963.900360996442, 5318.680879147263, 5319.962607291541, 5320.494553017457, 5326.334208223972, 5334.813281535127, 4122.237386083584, 4372.846950356786, 4681.461631912305, 4800.5199480051715, 4860.979194369152, 3707.94438083429, 3943.7042221832903, 3978.522577290744, 4052.696047796427, 4063.89840253996, 1097.742030622803, 1106.2422240765102, 1258.1256027061104, 1296.8911580598453, 1306.758249723804, 841.9031811341774, 904.7783293093235, 910.3718434280457, 936.7143021378545, 980.2109302011949, 4812.0, 5971.044632858809, 6000.716503463159, 6024.759009639565, 6035.456808887221, 905.3843386497246, 952.476138124029, 984.2863923655435, 992.1963209800085, 1002.3785253142952, 4021.7184797063924, 4036.1725846201457, 4060.4924384451942, 4099.0, 4105.4662893823615, 8625.0, 10575.947120264504, 10605.25763196569, 10661.307015043998, 10685.412302323446, 10605.681829545127, 10606.310589811637, 10620.628278010232, 10625.0, 10636.202284828669, 7710.383169346439, 8118.269355757892, 8128.227818357246, 8146.266835984789, 8196.262336389753, 5917.467427931335, 5975.133605627247, 6112.17485639433, 6123.785667501616, 6137.447629713347, 9871.555779989774, 9919.008099190023, 10079.0, 10131.7467063324, 10136.44249566281, 7750.457467977188, 9630.374025688308, 10123.088921997056, 10175.49122543855, 10185.115753585611, 6938.826529336807, 7163.032990546418, 7459.142198647225, 7629.54222746637, 7657.310842024244, 7966.123726389977, 8237.629306681094, 8243.340532757486, 8347.95826020866, 8350.87473687883, 6899.7235511430545, 7062.788116356517, 7270.745523906638, 7452.515586486861, 7567.167611562613, 6243.937560624336, 7350.595717235603, 7358.22738612438, 7496.0, 7520.887186692314, 6773.221079575715, 6972.1981972071835, 6978.860422791414, 6981.895271570829, 6997.090378250795, 4995.47547507521, 5029.421616514148, 5045.470225626256, 5069.847904562869, 5154.5103215194495, 4999.200127979506, 5053.772580233825, 5075.974620126875, 5244.344456942882, 5275.208718692227], "value": 4565.828958455591, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [253.34636637475293, 262.447547911646, 289.4038281140851, 301.48446157071413, 303.8526314737352, 4370.798030541602, 5110.974445127778, 5333.973330133344, 5346.492083252089, 5351.598630102739, 4056.7768772717563, 4494.876280929768, 5155.072087024343, 5216.374035115791, 5227.398849132351, 3316.3864685033227, 4030.919381612366, 4061.1521757600294, 4061.8984525386804, 4066.2883995300854, 3097.272141046852, 3834.827432765518, 4030.637242648161, 4039.6768258539246, 4095.344744840826, 3356.7482438817065, 4019.3970904364287, 4025.81883815229, 4044.9191016179657, 4062.573429789874, 3572.3034008368377, 3761.6082049641536, 4041.818118184689, 4044.635982761536, 4053.412255222976, 3559.1458050068054, 3573.392523271024, 3578.6779189873037, 3580.427131658948, 3595.658412450813, 4835.709857408567, 5075.492450754932, 5075.593952483792, 5210.66130701507, 5223.843284701465, 3850.3261929162286, 3922.411638254256, 4158.209940111369, 4284.100338928797, 4555.840545580889, 4549.818007279705, 5167.560757335631, 5393.514583687448, 5422.535915302846, 5471.562275017989, 3750.456183853353, 3755.3052685253315, 3761.4169803680475, 3761.9278505625766, 3777.941022142939, 5166.948330516722, 5287.757377016398, 5634.577406694473, 5655.3779084300695, 5662.886742265173, 3635.581908080552, 3808.733388662767, 3818.16000479894, 3823.4073718573663, 3828.904277393032, 3377.324535092991, 3651.1784848408897, 3660.9200285915717, 3680.7239457040296, 3930.292547341506, 3927.3323534999117, 4499.842505512292, 4520.254158063948, 4524.253498172765, 4543.363929049936, 5564.944350556523, 5602.467765562265, 5644.379118296984, 5663.461971112738, 5692.971535142297, 1048.8374301983206, 1244.2534479312521, 1285.7107150890974, 1324.3908650989094, 1327.2766342343252, 792.3740245206222, 806.9798255043671, 818.6438899078801, 821.4783612406166, 823.1932705948085, 4238.3430568261965, 4306.5022287073425, 4310.482742070909, 4321.120312664001, 4361.0841723237845, 4677.041206552649, 4721.504242054535, 4773.880652983634, 4803.495632958489, 4853.4418541868135, 3382.919504504761, 3643.2531331077594, 3792.6776224020714, 4101.589841015934, 4444.8444304449185, 2033.3086750504604, 2087.9038504784808, 2439.2071827206987, 2441.9145329913367, 2469.1111199967995, 4669.766511674403, 4797.4482934462985, 4815.22956326986, 4840.975795121002, 4895.8666453469805, 4132.958670413317, 4401.559844015637, 4690.100509293741, 4790.856274311776, 4800.255960326155, 3946.9013274668364, 4160.399750156153, 4754.667173297836, 4780.705261474512, 4925.802967881388, 4161.875143745692, 4214.494260688614, 4678.953210467852, 4821.590164836029, 4823.347159062431, 3760.3795373763023, 4335.132973405269, 4464.665150113689, 4701.271302948048, 4779.0, 4293.91412171761, 4722.5513576210205, 4902.8774280643265, 4919.2129259318335, 4945.530174633404, 2912.6504819421807, 3140.811551306929, 3453.240287136826, 3703.79629120401, 3743.6256374362347, 4685.4143232095985, 5552.33371995347, 5563.970665426909, 5574.609777315549, 5602.887942241214, 4398.450193725785, 4827.468978412442, 5093.159628661229, 5507.972460137674, 5509.779608815603, 4750.7862146202815, 5122.718250496258, 5498.45015498447, 5500.339959204761, 5531.917021244765, 4433.445819272591, 5106.0, 5407.810726624707, 5421.0, 5434.043744252145, 4591.403117594691, 5511.972440137773, 5565.4991050804, 5575.7490912909825, 5633.8309850704545, 4905.737684439808, 5073.792900088326, 5148.897022059463, 5317.787288508416, 5452.890942181055], "value": 3765.9901904981125, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.2731105239235, 732.6373445144658, 764.8164440534266, 782.6517199846068, 849.745076477057, 14962.32669529871, 15593.376264949402, 16284.104374259427, 16314.673706525891, 16341.0, 14602.634934126652, 14789.260536973163, 14799.92600037001, 14802.925985370084, 14826.406943722239, 663.7046514301138, 688.934551217636, 832.7210384521162, 839.630562552475, 846.4286606540592, 848.8429640516524, 858.026140330726, 860.101194252005, 861.5218553702692, 864.127231496187, 916.7891384981458, 918.2699753695828, 918.7243826851951, 920.1994264989469, 920.5443305563755, 707.3987110955698, 863.3783675753448, 910.7313342563959, 911.6581282019242, 916.1388295002677, 681.8636272745421, 682.8327059870314, 683.4464084091852, 683.9076724642209, 684.4353408438059, 14720.263986800725, 14751.557453276419, 14763.0, 14766.852331476655, 14798.112113273239, 13523.526676566273, 13589.796153057712, 13599.796003059962, 13738.931305343509, 13901.860981390259, 10538.841917371246, 12530.03673915204, 12869.227846329157, 12960.805587916095, 13253.360744902719, 4573.291139873291, 4606.930896036562, 4610.67725259232, 4782.0, 4790.281457781326, 110895.0, 112061.0, 120634.0, 121750.0, 122284.0, 10836.349819010884, 10881.727956801144, 10888.727781805359, 11018.944905275423, 11175.161862860317, 21154.0, 21182.0, 21183.470413239793, 21185.682214766483, 21208.78791212099, 7195.352418282275, 7372.0, 7456.40348772097, 7550.584717840462, 7720.343770779435, 4327.588879056548, 4387.670924680661, 4453.866384008485, 4454.910901781946, 4562.452505699337, 3365.764396492271, 3477.5826900772067, 3480.965190348064, 3483.233688588557, 3483.4252348362743, 633.5691729623808, 646.0857886091222, 648.176815444383, 662.1855118204635, 664.6211659354218, 529.1665626638061, 568.3208565763955, 621.2917274307293, 638.5913015669975, 640.8186582548906, 8558.272546833465, 8639.175667880105, 8855.141116993782, 8895.28837692983, 9029.013617004248, 585.3034888482692, 600.1537831657342, 601.8314871835893, 612.791650838717, 650.4211251985737, 4240.766757828349, 4354.586314300136, 4386.627136693417, 4433.955660443419, 4524.615407690318, 129424.0, 131399.0, 133428.0, 146943.0, 158368.62447063305, 115482.0, 116028.0136077485, 117977.0, 118209.40895295641, 118360.40819795846, 81018.0, 98242.0, 109111.45444272728, 112335.87664123418, 118744.0, 7954.772663654186, 9744.17174540172, 10021.599136034478, 10087.142592879687, 10126.645567405105, 56802.431975681364, 60238.69880650569, 61279.0, 61982.69008654928, 63752.68123659352, 70667.64666176637, 85944.0, 86836.56581717051, 93260.0, 94478.52760736152, 13438.328083595976, 13607.455701772215, 13840.0, 13926.442942282196, 14079.0848594841, 13567.38946747379, 14544.320218655028, 15110.697786044437, 15358.462453814063, 15556.455524056604, 13905.72188556203, 13906.0, 14057.507987220399, 14063.859361406256, 14677.0, 14102.36539355752, 14279.928600356932, 14283.500077497238, 14745.778813318024, 14883.702325953203, 13611.455541778218, 13728.176309421468, 14225.430982760574, 14268.714625707635, 14357.066790658573, 11450.198486105892, 11565.363904985306, 11687.0, 11718.121140914636, 11813.0, 10773.730656733644, 10905.890941090487, 11481.311121332747, 11627.360495172847, 11675.416229188677], "value": 7824.282517455227, "unit": "score"}], "name": "dromaeo_css", "value": 7301.813036854749, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 112.0, 111.0, 114.0, 112.0, 112.0, 113.0, 112.0, 113.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 108.0, 106.0, 161.0, 109.0, 105.0, 129.0, 109.0, 146.0, 105.0], "value": 122.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 186.0, 184.0, 184.0, 185.0, 184.0, 183.0, 187.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 58.0, 108.0, 57.0, 57.0, 60.0, 60.0, 98.0, 56.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 112.0, 71.0, 69.0, 68.0, 95.0, 75.0, 69.0, 128.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 83.0, 86.0, 84.0, 87.0, 85.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 111.0, 148.0, 114.0, 94.0, 93.0, 92.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 84.0, 81.0, 86.0, 71.0, 133.0, 136.0], "value": 93.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 54.0, 53.0, 55.0, 54.0, 54.0, 55.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 93.0, 111.0, 109.0, 75.0, 69.0, 71.0, 70.0, 69.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 82.0, 84.0, 84.0, 85.0, 85.0, 86.0, 88.0, 101.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 130.0, 144.0, 152.0, 147.0, 145.0, 135.0, 168.0, 153.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 171.0, 231.0, 195.0, 167.0, 165.0, 178.0, 223.0, 200.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 66.0, 70.0, 69.0, 64.0, 57.0, 69.0, 79.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1477.6000000000001, "alertThreshold": 2.0}]} 10:48:46 INFO - Return code: 0 10:48:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:48:46 INFO - # TBPL SUCCESS # 10:48:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:48:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:48:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:48:46 INFO - 2016-08-01 10:48:46.817 screenresolution[1963:26573] starting screenresolution argv=screenresolution get 10:48:46 INFO - 2016-08-01 10:48:46.820 screenresolution[1963:26573] Display 0: 1600x1200x32@60 10:48:46 INFO - 2016-08-01 10:48:46.827 screenresolution[1964:26575] starting screenresolution argv=screenresolution list 10:48:46 INFO - Available Modes on Display 0 10:48:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:48:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:48:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:48:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:48:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:48:47 INFO - Intel Iris: 10:48:47 INFO - Chipset Model: Intel Iris 10:48:47 INFO - Type: GPU 10:48:47 INFO - Bus: Built-In 10:48:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:48:47 INFO - Vendor: Intel (0x8086) 10:48:47 INFO - Device ID: 0x0a2e 10:48:47 INFO - Revision ID: 0x0009 10:48:47 INFO - Displays: 10:48:47 INFO - Display: 10:48:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:48:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:48:47 INFO - Display Serial Number: 1600x1200 60 10:48:47 INFO - Main Display: Yes 10:48:47 INFO - Mirror: Off 10:48:47 INFO - Online: Yes 10:48:47 INFO - Rotation: Supported 10:48:47 INFO - Return code: 0 10:48:47 INFO - Running post-action listener: _resource_record_post_action 10:48:47 INFO - ##### 10:48:47 INFO - ##### Finished run-tests step (success) 10:48:47 INFO - ##### 10:48:47 INFO - Running post-run listener: _resource_record_post_run 10:48:47 INFO - Total resource usage - Wall time: 1211s; CPU: 53.0%; Read bytes: 1012224; Write bytes: 706871296; Read time: 10; Write time: 1925 10:48:47 INFO - TinderboxPrint: CPU usage
53.5% 10:48:47 INFO - TinderboxPrint: I/O read bytes / time
1,012,224 / 10 10:48:47 INFO - TinderboxPrint: I/O write bytes / time
706,871,296 / 1,925 10:48:47 INFO - TinderboxPrint: CPU idle
2,255.2 (46.5%) 10:48:47 INFO - TinderboxPrint: CPU system
963.6 (19.9%) 10:48:47 INFO - TinderboxPrint: CPU user
1,627.0 (33.6%) 10:48:47 INFO - TinderboxPrint: Swap in / out
407,539,712 / 0 10:48:47 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396028416; Write bytes: 389608960; Read time: 29240; Write time: 712 10:48:47 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 1012224; Write bytes: 297277952; Read time: 10; Write time: 1166 10:48:47 INFO - Running post-run listener: _upload_blobber_files 10:48:47 INFO - Blob upload gear active. 10:48:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:48:47 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:47 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', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:48:47 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 Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:48:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:48:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:48:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:48:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:49 INFO - (blobuploader) - INFO - Done attempting. 10:48:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:48:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:48:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:48:50 INFO - (blobuploader) - INFO - Done attempting. 10:48:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:48:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:48:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:48:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: 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/Larch/sha512/16dfb36ffa6b4cf03a8b26505449122783bc31d6bed1c803e355e78ffba803648404bfb0eae671b5c6ff50cc3b360bee091f31427bcbf033c1f3a1a2f7646718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fff2f3eb27ae4379741a4c9859f82e55c1d1277d876ee53a5d54a58a10c4e2bf3043b92c0e6e059c3b18d6b955925e71141c771a93b7bb558ac4270ca05e2006", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c6c45b2ab00de115b284232245b7df1f50da3ca0a8f877111eccca77b2a27c82d0af22aa5b5e752c024c2ca63a6d588be01c6349a50c0c36ebef6a1376f1db30"} 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/Larch/sha512/16dfb36ffa6b4cf03a8b26505449122783bc31d6bed1c803e355e78ffba803648404bfb0eae671b5c6ff50cc3b360bee091f31427bcbf033c1f3a1a2f7646718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fff2f3eb27ae4379741a4c9859f82e55c1d1277d876ee53a5d54a58a10c4e2bf3043b92c0e6e059c3b18d6b955925e71141c771a93b7bb558ac4270ca05e2006", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c6c45b2ab00de115b284232245b7df1f50da3ca0a8f877111eccca77b2a27c82d0af22aa5b5e752c024c2ca63a6d588be01c6349a50c0c36ebef6a1376f1db30"} 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=1274.462476 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-08-01 10:48:52.585718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 10:48:52.589586) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STJcujnKxB/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/16dfb36ffa6b4cf03a8b26505449122783bc31d6bed1c803e355e78ffba803648404bfb0eae671b5c6ff50cc3b360bee091f31427bcbf033c1f3a1a2f7646718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fff2f3eb27ae4379741a4c9859f82e55c1d1277d876ee53a5d54a58a10c4e2bf3043b92c0e6e059c3b18d6b955925e71141c771a93b7bb558ac4270ca05e2006", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c6c45b2ab00de115b284232245b7df1f50da3ca0a8f877111eccca77b2a27c82d0af22aa5b5e752c024c2ca63a6d588be01c6349a50c0c36ebef6a1376f1db30"} build_url:https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/Fr9KPgekTjWcc1UzBXUawA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/16dfb36ffa6b4cf03a8b26505449122783bc31d6bed1c803e355e78ffba803648404bfb0eae671b5c6ff50cc3b360bee091f31427bcbf033c1f3a1a2f7646718", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/fff2f3eb27ae4379741a4c9859f82e55c1d1277d876ee53a5d54a58a10c4e2bf3043b92c0e6e059c3b18d6b955925e71141c771a93b7bb558ac4270ca05e2006", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c6c45b2ab00de115b284232245b7df1f50da3ca0a8f877111eccca77b2a27c82d0af22aa5b5e752c024c2ca63a6d588be01c6349a50c0c36ebef6a1376f1db30"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-01 10:48:52.626092) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 10:48:52.626413) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qn6Yb6JIBE/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.STJcujnKxB/Listeners TMPDIR=/var/folders/z2/7q46m13s59z0dctdqhn070sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005142 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-01 10:48:52.674880) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 10:48:52.675207) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-01 10:48:52.675525) ========= ========= Total master_lag: 0.20 =========