builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0247 starttime: 1468955900.49 results: success (0) buildid: 20160719100219 builduid: 6e3acec33c5743d78f6a0ca9ba535626 revision: 81925c21719eec3ba5c0a9f4ebfb06cb500571f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.488014) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.488497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.488809) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.513885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.514585) ========= 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.gwGBVQYcSK/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.yiEsejjI99/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-07-19 12:18:20-- 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% 156M=0s 2016-07-19 12:18:20 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125259 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.667286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.667600) ========= 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.gwGBVQYcSK/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.yiEsejjI99/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.035885 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:20.726988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 12:18:20.727453) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 81925c21719eec3ba5c0a9f4ebfb06cb500571f1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 81925c21719eec3ba5c0a9f4ebfb06cb500571f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gwGBVQYcSK/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.yiEsejjI99/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-07-19 12:18:20,808 truncating revision to first 12 chars 2016-07-19 12:18:20,808 Setting DEBUG logging. 2016-07-19 12:18:20,809 attempt 1/10 2016-07-19 12:18:20,809 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/81925c21719e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 12:18:21,434 unpacking tar archive at: autoland-81925c21719e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.892244 ========= master_lag: 0.40 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-19 12:18:22.021464) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:22.021976) ========= script_repo_revision: 81925c21719eec3ba5c0a9f4ebfb06cb500571f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:22.022425) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:22.022694) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 12:18:22.041919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-19 12:18:22.042570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.gwGBVQYcSK/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.yiEsejjI99/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:18:22 INFO - MultiFileLogger online at 20160719 12:18:22 in /builds/slave/test 12:18:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:18:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:18:22 INFO - {'append_to_log': False, 12:18:22 INFO - 'base_work_dir': '/builds/slave/test', 12:18:22 INFO - 'blob_upload_branch': 'Autoland', 12:18:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:18:22 INFO - 'branch': 'Autoland', 12:18:22 INFO - 'buildbot_json_path': 'buildprops.json', 12:18:22 INFO - 'config_files': ('talos/mac_config.py',), 12:18:22 INFO - 'default_actions': ('clobber', 12:18:22 INFO - 'read-buildbot-config', 12:18:22 INFO - 'download-and-extract', 12:18:22 INFO - 'populate-webroot', 12:18:22 INFO - 'create-virtualenv', 12:18:22 INFO - 'install', 12:18:22 INFO - 'run-tests'), 12:18:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:18:22 INFO - 'download_minidump_stackwalk': True, 12:18:22 INFO - 'download_symbols': 'ondemand', 12:18:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:18:22 INFO - 'tooltool.py': '/tools/tooltool.py', 12:18:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:18:22 INFO - '/tools/misc-python/virtualenv.py')}, 12:18:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:18:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:18:22 INFO - 'installer_path': 'installer.exe', 12:18:22 INFO - 'log_level': 'info', 12:18:22 INFO - 'log_name': 'talos', 12:18:22 INFO - 'log_to_console': True, 12:18:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:18:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:18:22 INFO - 'opt_config_files': (), 12:18:22 INFO - 'pip_index': False, 12:18:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:22 INFO - 'cmd': ('bash', 12:18:22 INFO - '-c', 12:18:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:22 INFO - 'enabled': True, 12:18:22 INFO - 'halt_on_failure': False, 12:18:22 INFO - 'name': 'check_screen_resolution'},), 12:18:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:18:22 INFO - 'cmd': ('bash', 12:18:22 INFO - '-c', 12:18:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:18:22 INFO - 'enabled': True, 12:18:22 INFO - 'halt_on_failure': False, 12:18:22 INFO - 'name': 'check_screen_resolution'},), 12:18:22 INFO - 'run_cmd_checks_enabled': True, 12:18:22 INFO - 'sps_profile': False, 12:18:22 INFO - 'sps_profile_interval': 0, 12:18:22 INFO - 'suite': 'dromaeojs-e10s', 12:18:22 INFO - 'system_bits': '32', 12:18:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:18:22 INFO - 'title': 't-yosemite-r7-0247', 12:18:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:18:22 INFO - 'use_talos_json': True, 12:18:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:18:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:18:22 INFO - 'work_dir': 'build'} 12:18:22 INFO - ##### 12:18:22 INFO - ##### Running clobber step. 12:18:22 INFO - ##### 12:18:22 INFO - Running pre-action listener: _resource_record_pre_action 12:18:22 INFO - Running main action method: clobber 12:18:22 INFO - rmtree: /builds/slave/test/build 12:18:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:18:24 INFO - Running post-action listener: _resource_record_post_action 12:18:24 INFO - ##### 12:18:24 INFO - ##### Finished clobber step (success) 12:18:24 INFO - ##### 12:18:24 INFO - ##### 12:18:24 INFO - ##### Running read-buildbot-config step. 12:18:24 INFO - ##### 12:18:24 INFO - Running pre-action listener: _resource_record_pre_action 12:18:24 INFO - Running main action method: read_buildbot_config 12:18:24 INFO - Using buildbot properties: 12:18:24 INFO - { 12:18:24 INFO - "project": "", 12:18:24 INFO - "product": "firefox", 12:18:24 INFO - "script_repo_revision": "production", 12:18:24 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 12:18:24 INFO - "repository": "", 12:18:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 12:18:24 INFO - "buildid": "20160719100219", 12:18:24 INFO - "pgo_build": "False", 12:18:24 INFO - "basedir": "/builds/slave/test", 12:18:24 INFO - "buildnumber": 33, 12:18:24 INFO - "slavename": "t-yosemite-r7-0247", 12:18:24 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 12:18:24 INFO - "platform": "yosemite_r7", 12:18:24 INFO - "scheduler": "tests-autoland-macosx64-talos", 12:18:24 INFO - "branch": "autoland", 12:18:24 INFO - "repo_path": "integration/autoland", 12:18:24 INFO - "revision": "81925c21719eec3ba5c0a9f4ebfb06cb500571f1", 12:18:24 INFO - "stage_platform": "macosx64", 12:18:24 INFO - "builduid": "6e3acec33c5743d78f6a0ca9ba535626", 12:18:24 INFO - "slavebuilddir": "test" 12:18:24 INFO - } 12:18:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 12:18:24 INFO - Running post-action listener: _resource_record_post_action 12:18:24 INFO - ##### 12:18:24 INFO - ##### Finished read-buildbot-config step (success) 12:18:24 INFO - ##### 12:18:24 INFO - ##### 12:18:24 INFO - ##### Running download-and-extract step. 12:18:24 INFO - ##### 12:18:24 INFO - Running pre-action listener: _resource_record_pre_action 12:18:24 INFO - Running main action method: download_and_extract 12:18:24 INFO - mkdir: /builds/slave/test/build/tests 12:18: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')]} 12:18:24 INFO - https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 12:18:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:18:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 12:18:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:25 INFO - Downloaded 1199 bytes. 12:18:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 12:18:25 INFO - Using the following test package requirements: 12:18:25 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:18:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 12:18:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 12:18:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'jsshell-mac.zip'], 12:18:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 12:18:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 12:18:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 12:18:25 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 12:18:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 12:18:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 12:18:25 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 12:18:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:18:25 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')]} 12:18:25 INFO - https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:18:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:18:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:18:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:26 INFO - Downloaded 18836043 bytes. 12:18:26 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'] 12:18:26 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 12:18:30 INFO - Return code: 0 12:18:30 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 12:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:30 INFO - https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:18:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:18:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 12:18:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:31 INFO - Downloaded 18836043 bytes. 12:18:31 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'] 12:18:31 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 12:18:35 INFO - Return code: 0 12:18:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:35 INFO - https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:18:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:18:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 12:18:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:36 INFO - Downloaded 14403317 bytes. 12:18:36 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'] 12:18:36 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 12:18:37 INFO - Return code: 0 12:18:37 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')]} 12:18:37 INFO - https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:18:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:18:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:18:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 12:18:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XVM5Tw64S22h9MftFVVydQ/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 12:18:40 INFO - Downloaded 112899872 bytes. 12:18:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:18:40 INFO - mkdir: /builds/slave/test/properties 12:18:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:18:40 INFO - Writing to file /builds/slave/test/properties/build_url 12:18:40 INFO - Contents: 12:18:40 INFO - build_url:https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 12:18:41 INFO - Running post-action listener: _resource_record_post_action 12:18:41 INFO - Running post-action listener: set_extra_try_arguments 12:18:41 INFO - ##### 12:18:41 INFO - ##### Finished download-and-extract step (success) 12:18:41 INFO - ##### 12:18:41 INFO - ##### 12:18:41 INFO - ##### Running populate-webroot step. 12:18:41 INFO - ##### 12:18:41 INFO - Running pre-action listener: _resource_record_pre_action 12:18:41 INFO - Running main action method: populate_webroot 12:18:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:18:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:18:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:18:41 INFO - '--tppagecycles', 12:18:41 INFO - '7'], 12:18:41 INFO - 'tests': ['tsvgm']}}, 12:18:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:18:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:18:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:18:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:18:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:18:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['damp', 'tps']}, 12:18:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'tests': ['damp', 'tps']}, 12:18:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['dromaeo_dom']}, 12:18:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:18:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['basic_compositor_video']}, 12:18:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:18:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['a11yr', 12:18:41 INFO - 'ts_paint', 12:18:41 INFO - 'tpaint', 12:18:41 INFO - 'sessionrestore', 12:18:41 INFO - 'sessionrestore_no_auto_restore', 12:18:41 INFO - 'tabpaint']}, 12:18:41 INFO - 'other-e10s': {'tests': ['a11yr', 12:18:41 INFO - 'ts_paint', 12:18:41 INFO - 'tpaint', 12:18:41 INFO - 'sessionrestore', 12:18:41 INFO - 'sessionrestore_no_auto_restore', 12:18:41 INFO - 'tabpaint']}, 12:18:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:18:41 INFO - 'ts_paint', 12:18:41 INFO - 'tpaint', 12:18:41 INFO - 'sessionrestore', 12:18:41 INFO - 'sessionrestore_no_auto_restore', 12:18:41 INFO - 'tabpaint']}, 12:18:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:18:41 INFO - 'ts_paint', 12:18:41 INFO - 'tpaint', 12:18:41 INFO - 'sessionrestore', 12:18:41 INFO - 'sessionrestore_no_auto_restore', 12:18:41 INFO - 'tabpaint']}, 12:18:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['a11yr', 12:18:41 INFO - 'ts_paint', 12:18:41 INFO - 'tpaint', 12:18:41 INFO - 'sessionrestore', 12:18:41 INFO - 'sessionrestore_no_auto_restore', 12:18:41 INFO - 'tabpaint']}, 12:18:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['a11yr', 12:18:41 INFO - 'ts_paint', 12:18:41 INFO - 'tpaint', 12:18:41 INFO - 'sessionrestore', 12:18:41 INFO - 'sessionrestore_no_auto_restore', 12:18:41 INFO - 'tabpaint']}, 12:18:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['tsvgx', 12:18:41 INFO - 'tsvgr_opacity', 12:18:41 INFO - 'tart', 12:18:41 INFO - 'tscrollx', 12:18:41 INFO - 'cart']}, 12:18:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:18:41 INFO - 'tsvgr_opacity', 12:18:41 INFO - 'tart', 12:18:41 INFO - 'tscrollx', 12:18:41 INFO - 'cart']}, 12:18:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'talos_options': ['--disable-e10s'], 12:18:41 INFO - 'tests': ['tp5o']}, 12:18:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'tests': ['tp5o']}, 12:18:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'talos_options': ['--disable-e10s', 12:18:41 INFO - '--xperf_path', 12:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:41 INFO - 'tests': ['tp5n']}, 12:18:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:18:41 INFO - 'talos_options': ['--xperf_path', 12:18:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:18:41 INFO - 'tests': ['tp5n']}}, 12:18:41 INFO - 'talos.zip': {'path': '', 12:18:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:18:41 INFO - Running post-action listener: _resource_record_post_action 12:18:41 INFO - ##### 12:18:41 INFO - ##### Finished populate-webroot step (success) 12:18:41 INFO - ##### 12:18:41 INFO - ##### 12:18:41 INFO - ##### Running create-virtualenv step. 12:18:41 INFO - ##### 12:18:41 INFO - Running pre-action listener: _resource_record_pre_action 12:18:41 INFO - Running main action method: create_virtualenv 12:18:41 INFO - Creating virtualenv /builds/slave/test/build/venv 12:18:41 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 12:18:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:18:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:18:41 INFO - Using real prefix '/tools/python27' 12:18:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:18:42 INFO - Installing distribute.............................................................................................................................................................................................done. 12:18:45 INFO - Installing pip.................done. 12:18:45 INFO - Return code: 0 12:18:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:18:45 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')]} 12:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:45 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')]} 12:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:45 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:18:45 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 12:18:45 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 12:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:45 INFO - 'HOME': '/Users/cltbld', 12:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:45 INFO - 'LOGNAME': 'cltbld', 12:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:45 INFO - 'MOZ_NO_REMOTE': '1', 12:18:45 INFO - 'NO_EM_RESTART': '1', 12:18:45 INFO - 'PAGER': '/bin/cat', 12:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:45 INFO - 'PWD': '/builds/slave/test', 12:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:45 INFO - 'SHELL': '/bin/bash', 12:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:18:45 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:45 INFO - 'USER': 'cltbld', 12:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:45 INFO - 'XPC_FLAGS': '0x0', 12:18:45 INFO - 'XPC_SERVICE_NAME': '0', 12:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:45 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 12:18:45 INFO - Cleaning up... 12:18:45 INFO - Return code: 0 12:18:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:18:45 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')]} 12:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:45 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')]} 12:18:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:45 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:18:45 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 12:18:45 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 12:18:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:18:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:45 INFO - 'HOME': '/Users/cltbld', 12:18:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:45 INFO - 'LOGNAME': 'cltbld', 12:18:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:45 INFO - 'MOZ_NO_REMOTE': '1', 12:18:45 INFO - 'NO_EM_RESTART': '1', 12:18:45 INFO - 'PAGER': '/bin/cat', 12:18:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:45 INFO - 'PWD': '/builds/slave/test', 12:18:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:45 INFO - 'SHELL': '/bin/bash', 12:18:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:18:45 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:18:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:45 INFO - 'USER': 'cltbld', 12:18:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:45 INFO - 'XPC_FLAGS': '0x0', 12:18:45 INFO - 'XPC_SERVICE_NAME': '0', 12:18:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:45 INFO - Downloading/unpacking psutil>=3.1.1 12:18:45 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 12:18:45 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 12:18:45 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 12:18:45 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 12:18:45 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 12:18:45 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 12:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:18:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:48 INFO - Installing collected packages: psutil 12:18:48 INFO - Running setup.py install for psutil 12:18:48 INFO - building 'psutil._psutil_osx' extension 12:18:48 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 12:18:49 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 12:18:49 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 12:18:49 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 12:18:49 INFO - building 'psutil._psutil_posix' extension 12:18:49 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 12:18:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:18:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:18:49 INFO - ^ 12:18:49 INFO - 1 warning generated. 12:18:49 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 12:18:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:18:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:18:49 INFO - Successfully installed psutil 12:18:49 INFO - Cleaning up... 12:18:50 INFO - Return code: 0 12:18:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:50 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:18:50 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 12:18:50 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 12:18:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:18:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:50 INFO - 'HOME': '/Users/cltbld', 12:18:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:50 INFO - 'LOGNAME': 'cltbld', 12:18:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:50 INFO - 'MOZ_NO_REMOTE': '1', 12:18:50 INFO - 'NO_EM_RESTART': '1', 12:18:50 INFO - 'PAGER': '/bin/cat', 12:18:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:50 INFO - 'PWD': '/builds/slave/test', 12:18:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:50 INFO - 'SHELL': '/bin/bash', 12:18:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:18:50 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:18:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:50 INFO - 'USER': 'cltbld', 12:18:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:50 INFO - 'XPC_FLAGS': '0x0', 12:18:50 INFO - 'XPC_SERVICE_NAME': '0', 12:18:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:18:50 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 12:18:50 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 12:18:50 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 12:18:50 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 12:18:50 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 12:18:50 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 12:18:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:18:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:18:52 INFO - Installing collected packages: mozsystemmonitor 12:18:52 INFO - Running setup.py install for mozsystemmonitor 12:18:52 INFO - Successfully installed mozsystemmonitor 12:18:52 INFO - Cleaning up... 12:18:53 INFO - Return code: 0 12:18:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:18: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')]} 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18: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')]} 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:18:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:18:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:18:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:18:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:53 INFO - 'HOME': '/Users/cltbld', 12:18:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:53 INFO - 'LOGNAME': 'cltbld', 12:18:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:53 INFO - 'MOZ_NO_REMOTE': '1', 12:18:53 INFO - 'NO_EM_RESTART': '1', 12:18:53 INFO - 'PAGER': '/bin/cat', 12:18:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:53 INFO - 'PWD': '/builds/slave/test', 12:18:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:53 INFO - 'SHELL': '/bin/bash', 12:18:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:18:53 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:18:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:53 INFO - 'USER': 'cltbld', 12:18:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:53 INFO - 'XPC_FLAGS': '0x0', 12:18:53 INFO - 'XPC_SERVICE_NAME': '0', 12:18:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:53 INFO - Downloading/unpacking jsonschema==2.5.1 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:18:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:56 INFO - Downloading functools32-3.2.3-2.tar.gz 12:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:18:56 INFO - warning: no files found matching '*.txt' 12:18:56 INFO - no previously-included directories found matching 'build' 12:18:56 INFO - no previously-included directories found matching 'dist' 12:18:56 INFO - no previously-included directories found matching '.git*' 12:18:56 INFO - Installing collected packages: jsonschema, functools32 12:18:56 INFO - Running setup.py install for functools32 12:18:56 INFO - warning: no files found matching '*.txt' 12:18:56 INFO - no previously-included directories found matching 'build' 12:18:56 INFO - no previously-included directories found matching 'dist' 12:18:56 INFO - no previously-included directories found matching '.git*' 12:18:56 INFO - Successfully installed jsonschema functools32 12:18:56 INFO - Cleaning up... 12:18:56 INFO - Return code: 0 12:18:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:18:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:18:56 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:18:56 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 12:18:56 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 12:18:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:18:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:18:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:18:56 INFO - 'HOME': '/Users/cltbld', 12:18:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:18:56 INFO - 'LOGNAME': 'cltbld', 12:18:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:56 INFO - 'MOZ_NO_REMOTE': '1', 12:18:56 INFO - 'NO_EM_RESTART': '1', 12:18:56 INFO - 'PAGER': '/bin/cat', 12:18:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:18:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:56 INFO - 'PWD': '/builds/slave/test', 12:18:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:18:56 INFO - 'SHELL': '/bin/bash', 12:18:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:18:56 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:18:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:18:56 INFO - 'USER': 'cltbld', 12:18:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:18:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:18:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:56 INFO - 'XPC_FLAGS': '0x0', 12:18:56 INFO - 'XPC_SERVICE_NAME': '0', 12:18:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:18:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:18:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:18:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:18:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:18:59 INFO - Downloading blobuploader-1.2.4.tar.gz 12:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:18:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:18:59 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 12:18:59 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 12:18:59 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 12:18:59 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 12:18:59 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 12:18:59 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 12:18:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:19:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:00 INFO - Downloading docopt-0.6.1.tar.gz 12:19:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:19:00 INFO - Installing collected packages: blobuploader, requests, docopt 12:19:00 INFO - Running setup.py install for blobuploader 12:19:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:19:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:19:00 INFO - Running setup.py install for requests 12:19:01 INFO - Running setup.py install for docopt 12:19:01 INFO - Successfully installed blobuploader requests docopt 12:19:01 INFO - Cleaning up... 12:19:01 INFO - Return code: 0 12:19:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19: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')]} 12:19:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19: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')]} 12:19:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:01 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:19:01 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 12:19:01 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 12:19:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:19:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:01 INFO - 'HOME': '/Users/cltbld', 12:19:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:01 INFO - 'LOGNAME': 'cltbld', 12:19:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:01 INFO - 'MOZ_NO_REMOTE': '1', 12:19:01 INFO - 'NO_EM_RESTART': '1', 12:19:01 INFO - 'PAGER': '/bin/cat', 12:19:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:01 INFO - 'PWD': '/builds/slave/test', 12:19:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:01 INFO - 'SHELL': '/bin/bash', 12:19:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:19:01 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:19:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:01 INFO - 'USER': 'cltbld', 12:19:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:01 INFO - 'XPC_FLAGS': '0x0', 12:19:01 INFO - 'XPC_SERVICE_NAME': '0', 12:19:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-NlRalJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:01 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-fDWSdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-uk29MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-i1nRP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-hJZOkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-5YkCK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-qBOeSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-pJrXve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ZrmDDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-zVhTBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-00peRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:02 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-EoxK_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:03 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ocNG5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:03 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-9ja1mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:03 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-QCliXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:03 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-AzIEkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:03 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-0gnOFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:19:03 INFO - Running setup.py install for manifestparser 12:19:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:19:03 INFO - Running setup.py install for mozcrash 12:19:03 INFO - Running setup.py install for mozdebug 12:19:04 INFO - Running setup.py install for mozdevice 12:19:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozfile 12:19:04 INFO - Running setup.py install for mozhttpd 12:19:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozinfo 12:19:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozInstall 12:19:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:19:04 INFO - Running setup.py install for mozleak 12:19:04 INFO - Running setup.py install for mozlog 12:19:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for moznetwork 12:19:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozprocess 12:19:05 INFO - Running setup.py install for mozprofile 12:19:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozrunner 12:19:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:19:05 INFO - Running setup.py install for mozscreenshot 12:19:05 INFO - Running setup.py install for moztest 12:19:06 INFO - Running setup.py install for mozversion 12:19:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:19:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:19:06 INFO - Cleaning up... 12:19:06 INFO - Return code: 0 12:19:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:06 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:19:06 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 12:19:06 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 12:19:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:19:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:06 INFO - 'HOME': '/Users/cltbld', 12:19:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:06 INFO - 'LOGNAME': 'cltbld', 12:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:06 INFO - 'MOZ_NO_REMOTE': '1', 12:19:06 INFO - 'NO_EM_RESTART': '1', 12:19:06 INFO - 'PAGER': '/bin/cat', 12:19:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:06 INFO - 'PWD': '/builds/slave/test', 12:19:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:06 INFO - 'SHELL': '/bin/bash', 12:19:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:19:06 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:19:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:06 INFO - 'USER': 'cltbld', 12:19:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:06 INFO - 'XPC_FLAGS': '0x0', 12:19:06 INFO - 'XPC_SERVICE_NAME': '0', 12:19:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:19:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-2EN1Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:19:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-cN_SX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:19:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-AHyJhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:19:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-blZY8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:19:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-x3kPw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:19:06 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)) 12:19:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:19:06 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ha_4QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ShUF0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-EIBc6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-21hXUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-gC_FZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-8Yg67L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-rQDpav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-onvmj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:19:07 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)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Eqqk3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:19:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:07 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-t292Kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:19:08 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)) 12:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:19:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-QFfAtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:19:08 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)) 12:19:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:19:08 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-3hzFoC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:19:08 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)) 12:19:08 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)) 12:19:08 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)) 12:19:08 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)) 12:19:08 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)) 12:19:08 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)) 12:19:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:19:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:19:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:19:10 INFO - Downloading blessings-1.6.tar.gz 12:19:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:19:10 INFO - Installing collected packages: blessings 12:19:10 INFO - Running setup.py install for blessings 12:19:10 INFO - Successfully installed blessings 12:19:10 INFO - Cleaning up... 12:19:11 INFO - Return code: 0 12:19:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:11 INFO - Reading from file tmpfile_stdout 12:19:11 INFO - Current package versions: 12:19:11 INFO - blessings == 1.6 12:19:11 INFO - blobuploader == 1.2.4 12:19:11 INFO - docopt == 0.6.1 12:19:11 INFO - functools32 == 3.2.3-2 12:19:11 INFO - jsonschema == 2.5.1 12:19:11 INFO - manifestparser == 1.1 12:19:11 INFO - mozInstall == 1.12 12:19:11 INFO - mozcrash == 0.17 12:19:11 INFO - mozdebug == 0.1 12:19:11 INFO - mozdevice == 0.48 12:19:11 INFO - mozfile == 1.2 12:19:11 INFO - mozhttpd == 0.7 12:19:11 INFO - mozinfo == 0.9 12:19:11 INFO - mozleak == 0.1 12:19:11 INFO - mozlog == 3.3 12:19:11 INFO - moznetwork == 0.27 12:19:11 INFO - mozprocess == 0.23 12:19:11 INFO - mozprofile == 0.28 12:19:11 INFO - mozrunner == 6.12 12:19:11 INFO - mozscreenshot == 0.1 12:19:11 INFO - mozsystemmonitor == 0.3 12:19:11 INFO - moztest == 0.7 12:19:11 INFO - mozversion == 1.4 12:19:11 INFO - psutil == 3.1.1 12:19:11 INFO - requests == 1.2.3 12:19:11 INFO - wsgiref == 0.1.2 12:19:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:19:11 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 12:19:11 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 12:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:11 INFO - 'HOME': '/Users/cltbld', 12:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:11 INFO - 'LOGNAME': 'cltbld', 12:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:11 INFO - 'MOZ_NO_REMOTE': '1', 12:19:11 INFO - 'NO_EM_RESTART': '1', 12:19:11 INFO - 'PAGER': '/bin/cat', 12:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:11 INFO - 'PWD': '/builds/slave/test', 12:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:11 INFO - 'SHELL': '/bin/bash', 12:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:19:11 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:11 INFO - 'USER': 'cltbld', 12:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:11 INFO - 'XPC_FLAGS': '0x0', 12:19:11 INFO - 'XPC_SERVICE_NAME': '0', 12:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 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)) 12:19:11 INFO - Cleaning up... 12:19:11 INFO - Return code: 0 12:19:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:19:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:19:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:19:11 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 0x101d3ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101dd3618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fba81494e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, '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.gwGBVQYcSK/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.yiEsejjI99/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 12:19:11 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 12:19:11 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 12:19:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:19:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:11 INFO - 'HOME': '/Users/cltbld', 12:19:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:11 INFO - 'LOGNAME': 'cltbld', 12:19:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:11 INFO - 'MOZ_NO_REMOTE': '1', 12:19:11 INFO - 'NO_EM_RESTART': '1', 12:19:11 INFO - 'PAGER': '/bin/cat', 12:19:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:11 INFO - 'PWD': '/builds/slave/test', 12:19:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:11 INFO - 'SHELL': '/bin/bash', 12:19:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:19:11 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:19:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:11 INFO - 'USER': 'cltbld', 12:19:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:11 INFO - 'XPC_FLAGS': '0x0', 12:19:11 INFO - 'XPC_SERVICE_NAME': '0', 12:19:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:19:11 INFO - Cleaning up... 12:19:11 INFO - Return code: 0 12:19:11 INFO - Running post-action listener: _resource_record_post_action 12:19:11 INFO - Running post-action listener: _start_resource_monitoring 12:19:11 INFO - Starting resource monitoring. 12:19:11 INFO - ##### 12:19:11 INFO - ##### Finished create-virtualenv step (success) 12:19:11 INFO - ##### 12:19:11 INFO - ##### 12:19:11 INFO - ##### Running install step. 12:19:11 INFO - ##### 12:19:11 INFO - Running pre-action listener: _resource_record_pre_action 12:19:11 INFO - Running main action method: install 12:19:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:19:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:19:12 INFO - Reading from file tmpfile_stdout 12:19:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:19:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:19:12 INFO - Reading from file tmpfile_stdout 12:19:12 INFO - Output received: 12:19:12 INFO - Usage: mozinstall [options] installer 12:19:12 INFO - Options: 12:19:12 INFO - -h, --help show this help message and exit 12:19:12 INFO - -d DEST, --destination=DEST 12:19:12 INFO - Directory to install application into. [default: 12:19:12 INFO - "/builds/slave/test"] 12:19:12 INFO - --app=APP Application being installed. [default: firefox] 12:19:12 INFO - mkdir: /builds/slave/test/build/application 12:19:12 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'] 12:19:12 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 12:19:46 INFO - Reading from file tmpfile_stdout 12:19:46 INFO - Output received: 12:19:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:19:46 INFO - Running post-action listener: _resource_record_post_action 12:19:46 INFO - ##### 12:19:46 INFO - ##### Finished install step (success) 12:19:46 INFO - ##### 12:19:46 INFO - ##### 12:19:46 INFO - ##### Running run-tests step. 12:19:46 INFO - ##### 12:19:46 INFO - Running pre-action listener: _resource_record_pre_action 12:19:46 INFO - Running main action method: run_tests 12:19:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:19:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:19:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:19:46 INFO - 2016-07-19 12:19:46.360 screenresolution[1636:7542] starting screenresolution argv=screenresolution get 12:19:46 INFO - 2016-07-19 12:19:46.363 screenresolution[1636:7542] Display 0: 1600x1200x32@60 12:19:46 INFO - 2016-07-19 12:19:46.368 screenresolution[1637:7544] starting screenresolution argv=screenresolution list 12:19:46 INFO - Available Modes on Display 0 12:19:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:19:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:19:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:19:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:19:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:19:46 INFO - Intel Iris: 12:19:46 INFO - Chipset Model: Intel Iris 12:19:46 INFO - Type: GPU 12:19:46 INFO - Bus: Built-In 12:19:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:19:46 INFO - Vendor: Intel (0x8086) 12:19:46 INFO - Device ID: 0x0a2e 12:19:46 INFO - Revision ID: 0x0009 12:19:46 INFO - Displays: 12:19:46 INFO - Display: 12:19:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:19:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:19:46 INFO - Display Serial Number: 1600x1200 60 12:19:46 INFO - Main Display: Yes 12:19:46 INFO - Mirror: Off 12:19:46 INFO - Online: Yes 12:19:46 INFO - Rotation: Supported 12:19:46 INFO - Return code: 0 12:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:19:46 INFO - Python 2.7.3 12:19:46 INFO - Return code: 0 12:19:46 INFO - grabbing minidump binary from tooltool 12:19:46 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')]} 12:19:46 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 0x101ca2d30>, '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 0x101a07db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101c9ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:19:46 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 12:19:46 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 12:19:46 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 12:19:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:19:46 INFO - Return code: 0 12:19:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:19:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:19:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:19:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:19:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:19:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.gwGBVQYcSK/Render', 12:19:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:19:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:19:46 INFO - 'HOME': '/Users/cltbld', 12:19:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:19:46 INFO - 'LOGNAME': 'cltbld', 12:19:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:19:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:19:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:19:46 INFO - 'MOZ_NO_REMOTE': '1', 12:19:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:19:46 INFO - 'NO_EM_RESTART': '1', 12:19:46 INFO - 'PAGER': '/bin/cat', 12:19:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:19:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:19:46 INFO - 'PWD': '/builds/slave/test', 12:19:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:19:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:19:46 INFO - 'SHELL': '/bin/bash', 12:19:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yiEsejjI99/Listeners', 12:19:46 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 12:19:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:19:46 INFO - 'USER': 'cltbld', 12:19:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:19:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:19:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:19:46 INFO - 'XPC_FLAGS': '0x0', 12:19:46 INFO - 'XPC_SERVICE_NAME': '0', 12:19:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:19:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:19:46 INFO - mozversion application_buildid: 20160719100219 12:19:46 INFO - mozversion application_changeset: 81925c21719eec3ba5c0a9f4ebfb06cb500571f1 12:19:46 INFO - mozversion application_display_name: Nightly 12:19:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:19:46 INFO - mozversion application_name: Firefox 12:19:46 INFO - mozversion application_remotingname: firefox 12:19:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:19:46 INFO - mozversion application_vendor: Mozilla 12:19:46 INFO - mozversion application_version: 50.0a1 12:19:46 INFO - mozversion platform_buildid: 20160719100219 12:19:46 INFO - mozversion platform_changeset: 81925c21719eec3ba5c0a9f4ebfb06cb500571f1 12:19:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:19:46 INFO - mozversion platform_version: 50.0a1 12:19:46 INFO - using testdate: 1468955986 12:19:46 INFO - actual date: 1468955986 12:19:46 INFO - starting webserver on 'localhost:49279' 12:19:46 INFO - SUITE-START | Running 2 tests 12:19:46 INFO - TEST-START | dromaeo_css 12:19:46 INFO - operating with platform_type : mac_ 12:19:46 INFO - Initialising browser for dromaeo_css test... 12:19:46 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpXLNqnu/profile http://localhost:49279/getInfo.html) 12:19:50 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 12:19:50 INFO - PROCESS | 1647 | colorDepth:24 12:19:50 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 12:19:50 INFO - PROCESS | 1647 | __metrics 12:19:50 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:19:50 INFO - TEST-INFO | 1647: exit 0 12:19:50 INFO - Browser initialized. 12:19:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:19:50 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpXLNqnu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:02 INFO - PROCESS | 1650 | RSS: Main: 254046208 12:20:02 INFO - PROCESS | 1650 | 12:20:52 INFO - PROCESS | 1650 | 1468956052489 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] 12:23:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 12:23:04 INFO - PROCESS | 1650 | RSS: Main: 268054528 12:23:04 INFO - PROCESS | 1650 | 12:26:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 12:26:07 INFO - PROCESS | 1650 | RSS: Main: 275460096 12:26:07 INFO - PROCESS | 1650 | 12:29:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 12:29:10 INFO - PROCESS | 1650 | RSS: Main: 279969792 12:29:10 INFO - PROCESS | 1650 | 12:32:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 12:32:12 INFO - PROCESS | 1650 | RSS: Main: 279400448 12:32:12 INFO - PROCESS | 1650 | 12:35:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 12:35:15 INFO - PROCESS | 1650 | RSS: Main: 282742784 12:35:15 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 12:38:18 INFO - PROCESS | 1650 | RSS: Main: 282865664 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | __start_tp_report 12:38:18 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 12:38:18 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 12:38:18 INFO - PROCESS | 1650 | |i|pagename|runs| 12:38:18 INFO - PROCESS | 1650 | |0;dojo.html;3112.8910488132915;3363.663633636636;3374.0552645259336;3406.1654894550825;3417.436123039697;5742.167385729072;5790.68151251681;5800.970995145029;5830.650160990333;5870.970645146779;4407.867763967086;5641.18202860585;5776.451237132465;5818.941810581893;5833.708314584275;5185.714785686786;5245.423003469616;5335.706536140511;5375.596830237729;5402.35171779385;456.56232244798576;5313.203019547061;5316.0962636351915;5332.173513105475;5402.8919421611545;5256.842294731164;5271.446498117681;5279.9440111977565;5299.708516031616;5309.203619457112;5219.451957544441;5317.654352467077;5338.706371149585;5345.144776835727;5347.037533244014;5218.765155568009;5231.581473482151;5254.789808407659;5272.815451459181;5284.154535274338;5770.682612456313;5848.766049358021;5864.648121112704;5876.2067120938555;5901.203337549418;6152.538559608002;6213.042891489166;6218.28489723683;6297.464715499188;6306.1171435998995;6256.718447669866;6263.060540918898;6271.498280137578;6280.968595157041;6281.937180628227;5942.168096466498;5944.108383742387;5955.5074543134615;5969.61197522164;6008.339082700856;6189.133521307021;6228.439440450381;6295.087212354183;6322.462590679752;6370.362963703686;6184.752609895644;6246.406591373812;6253.062040693932;6262.5929314594405;6271.027990661455;6161.815145545641;6264.091706702503;6281.183446151971;6285.962816135287;6298.968505157445;6131.448169664752;6194.4115309045565;6236.937630623726;6260.40526150015;6280.591761535486;5275.340582427197;6107.735039974563;6186.257649082049;6251.687415629201;6266.780662676875;4060.842659841931;4337.414449049401;4566.703164294377;4885.2427873679635;4993.375828021497;4431.889202769957;4441.555844415597;4452.0873220989615;4462.464504259509;4493.191225579361;5523.944760552424;5648.858778530487;6053.4854537363935;6056.818295451144;6073.210482637229;5305.814296499604;6270.2789179244055;6285.811425657238;6290.528210384239;6316.905246421307;5781.768729250867;5938.49522790559;5973.522118230531;6003.5797494174985;6037.275526936708;5498.697571633518;5502.779888804483;5519.558435325164;5523.917141242885;5537.141743029837;6180.134781130555;6383.616982981036;6385.201849768686;6406.167198264196;6415.230172379251;6206.534509911684;6212.161358216764;6248.281447633581;6256.687165641609;6287.591306565058;6396.488280937607;6401.391867772554;6413.262474815456;6427.839304017437;6432.549721519449;5982.52139828804;6189.164462797645;6290.842728931813;6292.559520833498;6297.811065668037;6197.659128747782;6230;6265.749370025148;6294.937050629435;6299.622022678654;5973.074173503114;6078.817635470943;6262.749490020348;6281.623102613858;6286.119943208046;6100.969495152496;6128.380904898417;6171.352008039091;6242.53181011435;6307.085472606538;5888;5900.996830538733;5990.371011043778;6028.306744724237;6143.508519318533;6162.260528736401;6181.5363847710705;6197.194364732556;6210.378962103753;6214.974529202631;5926.911096333472;6045.002574575145;6045.486133678686;6115.694215289129;6132.693365331805 12:38:18 INFO - PROCESS | 1650 | |1;ext.html;433.5296203619073;510.68082448469704;526.8814516733735;551.2255281329732;592.6207227374484;39464.2107157857;42175.15649687005;42187.78906105465;42252.788736056275;42442.57557424425;42696.57303426965;42747.57252427475;43356.699299021;43379.56620433803;43391.78304108475;9779.168770654504;9951.502424878763;9960.352577082504;9977.15194208493;9996.700098997042;9430.717078487656;9815.901840981605;9852.556634951445;9929.801403971916;9958.402495850236;9912;9922.851157232648;9944.204463642927;9951.601935922554;9998.150157236607;9879.209663226924;9929.602815887356;9932.652357167537;9951.80096398068;9959.502024898726;9679.564419601065;9681;9696.030396960317;9742;9823.557939892722;40464.79767601143;40890;41007;41469.792651036856;41578.79210603928;3045.8629361678777;3258.657840926716;3332.5501057357433;3468.0982944434377;3495.73781966351;29677.109686709435;31074.689253107405;31233.687663123306;31772.20569485758;32006;2633.2363614551755;2768.3632764464087;3202.7277681396877;3228.1122691259857;3351;439468;441743;443506;443575;444378;28216.576751348744;32932;33643.15892102717;34221.48667769985;35115;35161.824190878884;35402;35467;35570.28859422797;35639;14552.563423097325;14790;14970.026948248547;14979.850201498064;15025.248737563079;12350.38248087592;12556.372181390894;12624.747505049847;12663.936680316723;12708.919741821865;6485.967570162214;7572.5835079070075;7620.5808680523105;7636.350910172698;7738.535687858746;3177.9682203178136;3212.2772376215166;3222.6777322267585;3229.3379857129703;3239.0606724049762;936.6581197862868;976.2677991506371;1006.2905651515664;1006.3408467453829;1055.7307886488895;31329.530057049164;31386.21534461611;31568;31675.841620791747;31717.524237136462;1094.5895289266525;1099.219554116586;1099.5656715597295;1163.2962057954985;1168.4800263882491;13801.309934503235;16270.83729162717;16273.860829742041;16402.507924762278;16753.748693769605;417142;484528;485965;487164;488454;47244;51407.22889156666;60784.696076519336;61359;62226;1378.0216046607022;1418.44680574576;1424.7008128293176;1429.2353590828857;1434.8565143485569;26761.929522818868;30116.548251775803;30832.845835770677;30837.074887753402;31020;48406.5159348402;48688.75655621699;48822.511774881794;49185.754071229414;49276.75361623169;486161;488184;488757.11242887116;489334;489475;27256.72743272542;27622.585661214696;27714.307142321602;27993.720062799926;28652.42695146127;50332.74833625808;50356.24465632945;50901;51073.23390149076;51521;40380;41781;41865;42859.928501787705;42899.5710042908;41394.172116556896;41986;42299.57700422956;42454.5754542463;42667.78666106649;38788.6121138785;39188;40338.596614033486;40390.59609403869;40408.59591404048;34510.827445863615;35640.82179589086;36266;36671.81664091662;36859.07852303714;21614;26212.082577109708;26229.606555901297;26735.86632066905;27089.593656095567 12:38:18 INFO - PROCESS | 1650 | |2;jquery.html;380.73729126902435;384.37538999126417;390.44343218369437;392.30561905427396;409.3838772647167;15080.773788393182;16103.91948040261;16319.69442444603;19175.52061198469;20004.799952000474;20658.586828263426;20934.685979710277;20994.790052099474;21791.564168716617;22076.22733204338;5579.8605034874045;5931.73307201177;5942.940570594282;6073.60521566099;6250.093736408218;5264.552513036397;5900.321463031742;5998;6014.8195554133445;6041.879162416749;5980.10298455233;5983.072623743326;5999.910001349961;6100.908486372708;6123.755049798025;5213.817516386908;6015.097735339712;6113.113598528211;6125.877482450348;6153.846153846145;5879;5907.9704601476715;5917.408259174092;5938.970305148447;5957.702114894281;25909.870450647813;26315.868420657775;26755.46489070227;26831.060912867957;26913.327166820985;2192.48476607997;2511.5604769165507;2694.986525067362;2880.2367372646268;2982.3140677644265;9769.951150244275;10289.639862604849;10307.278490505667;10440.269181157322;10517.63188288414;1920.2798950393603;1925.0855843474378;1932.792004996877;1964.9705254421194;1974.3780709076595;128350.35824820815;134499.6550034497;135300;135485.3225733875;135571.32214338865;9325.953370233241;11234;11415.258008229439;11716.355600441888;11774;14637.560873173821;14684.559463216121;14693.412263509339;14720.337584808709;14742.631434214016;7062.646867656596;7252;8607.18231767981;8765.868511972325;8769.079246679006;8667.133286671282;8675.91324086751;8677.088905664941;8777.780555486164;8790.91209087901;3744.7565908216425;4491.528389519119;4523.638108951276;4559.974005848658;4614.238650622677;1918.3861164427528;1948.9025548722507;1958.6180694764384;2004.83961283097;2010.1456880825883;766.6779952419997;862.4092496639822;901.1439132823843;921.2721949659827;922.4787994783061;20774;21360.78639213619;21444.892775536333;21463;21499.355019349445;945.2154711589365;976.2677991506371;1007.2848277722899;1029.6910926721953;1032.8554002439664;8588.527630980356;11371.601993930173;11373.715657108638;11390.202685811913;11446.713832154262;634639;635400.6459935341;636079;644688;646861;101816;138119.56923876697;143688;149370;149970.25014875075;816.1675091406731;1025.0671888581205;1029.0738335497963;1033.2973577967055;1039.2205845615788;19679.31122410709;19839.60320793605;20374.28689995843;20604.58790824205;21533.569328613652;57819;58462.7076864613;59837.70081149566;60036.09945850903;60589.394106058375;79774.60112699399;80222.5988870052;80641.3871722574;81120;83367.16632833594;8265.421420500748;8346.707865224687;8371.581420928807;8440.535770532433;8558.400911936355;11493.54025838957;13358.799618005543;13534.323283835965;13642.454301828213;13677.589672309847;11493.82759258595;11624;11710.824337635113;11720;11726.00328972047;11343.035841953526;11389.601363952223;11462.713432164262;11588.710282243012;11746.884046015615;11374.601888933848;11718.589849355572;11797.410129493663;11911.047116230508;12112.454939527566;8252.669893204205;8299.087100418828;8371.748847534584;8510.021347545111;8586.398952073296;9313.34806563534;10375.896241037493;10876.293040952629;10987.450627468435;11048.779024419628 12:38:18 INFO - PROCESS | 1650 | |3;mootools.html;1559.9626248544719;1593.2670971353177;1826.835584797368;1916.942491725248;1935.080836602613;7429.36850367718;8582.098879617628;8633.395662303641;8698.217160455566;9173;7552.8867066994035;8805.64777408903;8855.734327970154;8941.91058089419;8947.060558641346;2275.306031660343;2295.8737269450176;2362.4802543440414;2391.9714522755207;2395.6765836612008;2362.492064206204;2383.0348708772976;2391.701037370329;2404.9398765030837;2407.9398015049587;2055.3114706573315;2380.4762952150586;2380.9880950595225;2383.1420688552107;2404.8196385271085;2303.0787684925995;2376.5603363377745;2386.033656369173;2388.8208384371155;2391.7249516305587;2345.425370784169;2346.249200255919;2371.2412028150998;2371.4071482129466;2389.1279682915783;8954.86567701485;9025.864612030824;9025.909740902573;9027.909720902773;9047.050059743764;5201.55786758126;5317.229001794718;5335.946640533583;5355.0896347621;5424.484673955968;3492.161881148506;3495.545579074704;3557.1107223194203;3566.4828599852876;3569.321828852536;1078.95684172633;1084.3060441317564;1091.8689757229183;1104.917131215162;1109.2845114900924;11446.370449625267;11583.478743456564;11627.12796540263;11632.069434445224;11646.126540509411;4571.885702857455;4583.54164583539;4742.359781429463;4747.8575642730775;4801.351817504592;9905.653302134535;9927.156191723785;9929.652462163935;9937.205023598095;10001.549930253155;5333.280007198979;5339.199120132012;5344.278522399504;5344.599155063386;5374.5700343972385;4359.651227901823;4768.809247630056;4903.239997800347;4910.533499317559;4927;3289.605247370283;3489.2149266415363;3685.6867166291167;4061.634452899253;4082.408050832613;1299.2074834351038;1312.5930961401996;1313.8883194928346;1316.2431601828987;1340.1021315718492;949.8432758594754;951.357833462424;952.3571589177278;975.3757595139117;1004.1549523548906;5249.107651699221;5974.820755377345;5988.101784732238;6070.7875224366935;6143.354947730513;438.283406630162;452.40734637624814;452.47738861614886;466.89494863656085;467.66094581428194;4065.593440655911;4143.109231515239;4151.418801367811;4159.854405095807;4204.07510347723;10327.277090603737;10594.258401911946;10643.733906652396;10766.300190487593;10770.78458430827;10602.893971060344;10762.085222755997;10779.461026948622;10790.838137427787;10899;7032.507724459341;7391.669499490144;8219.260266576037;8317.168283171635;8455.873161902577;6035.969820151046;6118.326984031664;6153.969230153821;6227.097070924781;6303.46420554258;9911.45486998222;10060.144887684628;10270.845937310796;10374.325668831803;10398.68803935883;8774.605142768718;10486.47567621631;10515.106215971728;10524.31591946521;10562.155027597928;6997.090378250795;7315.451341149329;7661.693532258647;7670.884936725842;7806;8373.455725377831;8510.914890851012;8557.828843423222;8562.357823163413;8570.357223208159;7482.401407887247;7562.281583249583;7586.582737949245;7637.007189065386;7704.961475192588;7391.40868730511;7403;7448.702051917862;7516.962415187889;7571.507851989603;6950.687219075053;6994.790156295319;7033.788986330418;7039.6832142552685;7083;4978.726170060681;5051.419086805065;5055.014272216882;5091;5165.741712914414;3985.4619626350072;5159.613029022763;5184.300119483822;5188.988147311238;5345.705986170798 12:38:18 INFO - PROCESS | 1650 | |4;prototype.html;313.55788338442784;316.65326467518065;321.91308346746376;327.22284574136427;328.60567319216943;4692.389989301386;5416.322959630046;5471.890562188763;5599.692016939067;5651.463111004453;5535.169724541321;5553.305836770403;5560.387487628583;5573.749181286842;5599.664020158793;4215.388768628547;4217.704760666755;4219.725717828339;4254.893627659302;4256.148770245948;4020.2160578687167;4204.2432362174795;4214.367844823286;4247.575242475743;4271.287732289987;3465.826708664569;4179.435776170224;4188.81150348235;4189.622933935945;4201.953583651859;3724.0262660789826;4023.2959232134554;4201.138766552849;4241.6818738594575;4243.936340954888;3038.787284890059;3175.904722858318;3671.889843304705;3674.7243956703355;3681.7790932544135;4719.551642593982;5175.637705360627;5488.643238189505;5500.50495455407;5523.530499907512;4791.329213910055;4883.584895283905;4888.0468308679465;4903.901921961541;4907.558319751204;5187.325647665817;5629.774809007635;5901.8819623607715;5926;5999;3642.6357364263363;3674.8346324415465;4053.6959728020515;4060.2488539620263;4072.348424252135;5737.991702903992;6216.880961426941;6282.497400208018;6294.213223347082;6297.622142671455;3606.972012976289;3747.606501317377;3841.501814292428;4135.627793498599;4138.255114079434;3794.449804778347;3878.4376265441915;4103.322951712994;4113.074558224375;4113.938290925638;4199.265128602482;4325.3728209409455;4781.517729503865;4818.590419814355;4830.903381932341;5651.491365777099;5988.610740301867;6009.639421634629;6022.5483088768515;6057.878842423215;1227.5642147037852;1359.2872980045215;1396.84634690184;1400.4188261871413;1406.6694326833185;794.654325368455;834.5701963488808;835.4402550291198;846.9153084691604;862.9439086459486;4131.35963925592;4612.792424340845;4643.233866412072;4665.953340466552;4693.5071817458675;4641.327007583882;5070.518300761421;5135.6405051646025;5198.906650542921;5226.947730522722;4018.3369743991916;4252.851150209728;4472.44094488189;4511.834319526645;4682.41469816273;2990.7308342249303;3113.2683819302447;3307.7353811695007;3310.8013519188926;3319.5850518685165;5336.813211537577;5511.090670039479;5902.586818922634;6401.711922963478;6437;5687.004774164505;6068;6322.841928951813;6346.492280617539;6409.8077057687415;6396.392342727433;6414.1340918976275;6416.647084410402;6465.612063276219;6480.347511384661;4842.491538388418;5667.943320566742;6181.196444462191;6191.628502289877;6193.163922870535;4754.904901902012;5831.82504524848;5846.649201047951;5937.109433584824;6094.268687757321;5547.029269877836;5629.339344893348;6080.787172448943;6191.349908259568;6450.774222902176;3255.723263522627;3870.5161854768153;3966.6826653868197;4041.6766658666647;4082.3468245080644;5964.403559644001;6164.167837342081;6201.81394558164;6213.596116252429;6258.249010118815;4702.401183597456;4975.477574854733;5865.765369385347;5966.612170208922;5968.820935371946;5129.923051154161;5831.717022255267;5979.594795223032;5987.43119403656;6041.305249896318;5678.943210568007;5737.627054241461;5798.5646028667215;5822.3304320003745;5885.323187833283;5619;5713.400092990176;5926.67403292823;5959.880802384015;6015.759369625341;5109.923351149661;5527.668339899458;5832.154337621106;5861.710423706778;5868.354481007171 12:38:18 INFO - PROCESS | 1650 | |5;yui.html;751.2037240525043;773.9187385324537;781.5193655901622;838.3754103193122;884.8584226523758;15449.845501544982;15820.367185312602;15968.361265549363;15974;15988.04071755694;14536.127832330041;15764.763528547051;16308.83691163088;16361.590960226;16675;726.7601691441812;921.6866265469756;937.929655275857;945.7399215215836;947.9004704505996;904.4392476664477;916.9403988740711;938.713692323841;941;943.2925306020485;931.7204838548442;954.5704433005176;987.8518222266681;988.2341185581196;1000.5297510170209;925.2597921662676;942.8915674697395;976.8485884687884;980.8577756225379;982.3418309732425;688.50771698236;721.1634503975364;729.5476804381318;739.1389031777973;743.1528058013869;15541.222938853125;15629.687406251925;15820.446284380107;15874.285657145456;15887.443939462179;14107.576772696835;14402;14488.275586220647;14493.56519304412;14540.982131250817;8862.42394244372;9968.850467242997;10111.89888101117;11562.884371156264;12466.127371084027;3897.142628621699;3951.38753493209;3969.3649016157565;4073.06319546503;4096.897577560555;94854.628634284;111737;113243;113543.43228283888;116337.09157271136;11281.074558998016;11317.603883864025;11431.256968297033;11471.942640286912;11871.0503159747;22398.440038999157;22404.32787016392;22425;22449.551008980055;22611.43471413228;7896.486728362638;8176.264136227649;8231.794205144919;8234.711785087493;8317.875231871527;4500.279955207151;4524.366588677588;4565.56627120423;4591.403117594758;4711.575958163782;3139.293658926769;3587.712982961357;3589.6410358963894;3590.2460483298278;3591.030421786103;606.4572207873928;642.9710663020176;645.9515536334794;659.2484567592948;663.2174034639075;509.66362200947196;678.7081554931328;691.4192078653955;700.4851434195862;704.7427688893517;8833.425827321204;9117.498537580364;9334.953325233466;9487.76280592977;9571.61713531451;642.392938672959;650.5998810731461;696.6238231355012;699.989500157498;700.7162099349772;4413.514513403523;4455.554444555583;4513.480949690827;4558.772061396917;4626.629869610423;140079.5992040087;142399;146349;154969;156771;135239;138596.30701846626;140133;140214;141040;101427;105060;105345.47327263314;107003.39494907582;109608.4519577413;8707.172818582225;8796.384253102222;8800.207981281716;8836.823263534821;9006.189442950166;64262.67868660627;66179.35282588835;66329.66835165986;66874.66562667156;66887.66556167188;92668.53665731628;97377.0262297368;99572;100221;101745.49127254612;9834.704958851245;11693.76612467763;11851.762964740828;11955.701107472383;12105.81841272364;13244.337783111;14672.37313994765;15343.846561534241;15696.372145114068;15704.214789260719;14146.504872329419;14203.715925681636;14319.069260498034;14663.92668036653;14816.48142315057;14159.079659822079;14203.28983550839;14221.360038798071;14310.785338220143;14532.927335363256;13640.931795340959;13716.908890847453;13730.107543009672;13974;14019.158850469004;11232.871243649997;11328.433578321215;11744.236624619372;11890.940545297219;11896.464659090534;11014.339139651647;11526;11586.304821710388;11598.594049208237;11780.293182409083 12:38:18 INFO - PROCESS | 1650 | __end_tp_report 12:38:18 INFO - PROCESS | 1650 | __start_cc_report 12:38:18 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,434 12:38:18 INFO - PROCESS | 1650 | __end_cc_report 12:38:18 INFO - PROCESS | 1650 | __startTimestamp1468957098867__endTimestamp 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | ------- Summary: start ------- 12:38:18 INFO - PROCESS | 1650 | Number of tests: 6 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5758.83 Median:6045.49 stddev:791.48 (13.1%) stddev-sans-first:766.20 12:38:18 INFO - PROCESS | 1650 | Values: 3112.9 3363.7 3374.1 3406.2 3417.4 5742.2 5790.7 5801.0 5830.7 5871.0 4407.9 5641.2 5776.5 5818.9 5833.7 5185.7 5245.4 5335.7 5375.6 5402.4 456.6 5313.2 5316.1 5332.2 5402.9 5256.8 5271.4 5279.9 5299.7 5309.2 5219.5 5317.7 5338.7 5345.1 5347.0 5218.8 5231.6 5254.8 5272.8 5284.2 5770.7 5848.8 5864.6 5876.2 5901.2 6152.5 6213.0 6218.3 6297.5 6306.1 6256.7 6263.1 6271.5 6281.0 6281.9 5942.2 5944.1 5955.5 5969.6 6008.3 6189.1 6228.4 6295.1 6322.5 6370.4 6184.8 6246.4 6253.1 6262.6 6271.0 6161.8 6264.1 6281.2 6286.0 6299.0 6131.4 6194.4 6236.9 6260.4 6280.6 5275.3 6107.7 6186.3 6251.7 6266.8 4060.8 4337.4 4566.7 4885.2 4993.4 4431.9 4441.6 4452.1 4462.5 4493.2 5523.9 5648.9 6053.5 6056.8 6073.2 5305.8 6270.3 6285.8 6290.5 6316.9 5781.8 5938.5 5973.5 6003.6 6037.3 5498.7 5502.8 5519.6 5523.9 5537.1 6180.1 6383.6 6385.2 6406.2 6415.2 6206.5 6212.2 6248.3 6256.7 6287.6 6396.5 6401.4 6413.3 6427.8 6432.5 5982.5 6189.2 6290.8 6292.6 6297.8 6197.7 6230.0 6265.7 6294.9 6299.6 5973.1 6078.8 6262.7 6281.6 6286.1 6101.0 6128.4 6171.4 6242.5 6307.1 5888.0 5901.0 5990.4 6028.3 6143.5 6162.3 6181.5 6197.2 6210.4 6215.0 5926.9 6045.0 6045.5 6115.7 6132.7 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:60381.56 Median:40677.40 stddev:124515.36 (306.1%) stddev-sans-first:124783.31 12:38:18 INFO - PROCESS | 1650 | Values: 433.5 510.7 526.9 551.2 592.6 39464.2 42175.2 42187.8 42252.8 42442.6 42696.6 42747.6 43356.7 43379.6 43391.8 9779.2 9951.5 9960.4 9977.2 9996.7 9430.7 9815.9 9852.6 9929.8 9958.4 9912.0 9922.9 9944.2 9951.6 9998.2 9879.2 9929.6 9932.7 9951.8 9959.5 9679.6 9681.0 9696.0 9742.0 9823.6 40464.8 40890.0 41007.0 41469.8 41578.8 3045.9 3258.7 3332.6 3468.1 3495.7 29677.1 31074.7 31233.7 31772.2 32006.0 2633.2 2768.4 3202.7 3228.1 3351.0 439468.0 441743.0 443506.0 443575.0 444378.0 28216.6 32932.0 33643.2 34221.5 35115.0 35161.8 35402.0 35467.0 35570.3 35639.0 14552.6 14790.0 14970.0 14979.9 15025.2 12350.4 12556.4 12624.7 12663.9 12708.9 6486.0 7572.6 7620.6 7636.4 7738.5 3178.0 3212.3 3222.7 3229.3 3239.1 936.7 976.3 1006.3 1006.3 1055.7 31329.5 31386.2 31568.0 31675.8 31717.5 1094.6 1099.2 1099.6 1163.3 1168.5 13801.3 16270.8 16273.9 16402.5 16753.7 417142.0 484528.0 485965.0 487164.0 488454.0 47244.0 51407.2 60784.7 61359.0 62226.0 1378.0 1418.4 1424.7 1429.2 1434.9 26761.9 30116.5 30832.8 30837.1 31020.0 48406.5 48688.8 48822.5 49185.8 49276.8 486161.0 488184.0 488757.1 489334.0 489475.0 27256.7 27622.6 27714.3 27993.7 28652.4 50332.7 50356.2 50901.0 51073.2 51521.0 40380.0 41781.0 41865.0 42859.9 42899.6 41394.2 41986.0 42299.6 42454.6 42667.8 38788.6 39188.0 40338.6 40390.6 40408.6 34510.8 35640.8 36266.0 36671.8 36859.1 21614.0 26212.1 26229.6 26735.9 27089.6 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:37228.29 Median:26112.87 stddev:107043.98 (409.9%) stddev-sans-first:107308.51 12:38:18 INFO - PROCESS | 1650 | Values: 380.7 384.4 390.4 392.3 409.4 15080.8 16103.9 16319.7 19175.5 20004.8 20658.6 20934.7 20994.8 21791.6 22076.2 5579.9 5931.7 5942.9 6073.6 6250.1 5264.6 5900.3 5998.0 6014.8 6041.9 5980.1 5983.1 5999.9 6100.9 6123.8 5213.8 6015.1 6113.1 6125.9 6153.8 5879.0 5908.0 5917.4 5939.0 5957.7 25909.9 26315.9 26755.5 26831.1 26913.3 2192.5 2511.6 2695.0 2880.2 2982.3 9770.0 10289.6 10307.3 10440.3 10517.6 1920.3 1925.1 1932.8 1965.0 1974.4 128350.4 134499.7 135300.0 135485.3 135571.3 9326.0 11234.0 11415.3 11716.4 11774.0 14637.6 14684.6 14693.4 14720.3 14742.6 7062.6 7252.0 8607.2 8765.9 8769.1 8667.1 8675.9 8677.1 8777.8 8790.9 3744.8 4491.5 4523.6 4560.0 4614.2 1918.4 1948.9 1958.6 2004.8 2010.1 766.7 862.4 901.1 921.3 922.5 20774.0 21360.8 21444.9 21463.0 21499.4 945.2 976.3 1007.3 1029.7 1032.9 8588.5 11371.6 11373.7 11390.2 11446.7 634639.0 635400.6 636079.0 644688.0 646861.0 101816.0 138119.6 143688.0 149370.0 149970.3 816.2 1025.1 1029.1 1033.3 1039.2 19679.3 19839.6 20374.3 20604.6 21533.6 57819.0 58462.7 59837.7 60036.1 60589.4 79774.6 80222.6 80641.4 81120.0 83367.2 8265.4 8346.7 8371.6 8440.5 8558.4 11493.5 13358.8 13534.3 13642.5 13677.6 11493.8 11624.0 11710.8 11720.0 11726.0 11343.0 11389.6 11462.7 11588.7 11746.9 11374.6 11718.6 11797.4 11911.0 12112.5 8252.7 8299.1 8371.7 8510.0 8586.4 9313.3 10375.9 10876.3 10987.5 11048.8 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5733.96 Median:4758.33 stddev:3226.49 (67.8%) stddev-sans-first:3220.30 12:38:18 INFO - PROCESS | 1650 | Values: 1560.0 1593.3 1826.8 1916.9 1935.1 7429.4 8582.1 8633.4 8698.2 9173.0 7552.9 8805.6 8855.7 8941.9 8947.1 2275.3 2295.9 2362.5 2392.0 2395.7 2362.5 2383.0 2391.7 2404.9 2407.9 2055.3 2380.5 2381.0 2383.1 2404.8 2303.1 2376.6 2386.0 2388.8 2391.7 2345.4 2346.2 2371.2 2371.4 2389.1 8954.9 9025.9 9025.9 9027.9 9047.1 5201.6 5317.2 5335.9 5355.1 5424.5 3492.2 3495.5 3557.1 3566.5 3569.3 1079.0 1084.3 1091.9 1104.9 1109.3 11446.4 11583.5 11627.1 11632.1 11646.1 4571.9 4583.5 4742.4 4747.9 4801.4 9905.7 9927.2 9929.7 9937.2 10001.5 5333.3 5339.2 5344.3 5344.6 5374.6 4359.7 4768.8 4903.2 4910.5 4927.0 3289.6 3489.2 3685.7 4061.6 4082.4 1299.2 1312.6 1313.9 1316.2 1340.1 949.8 951.4 952.4 975.4 1004.2 5249.1 5974.8 5988.1 6070.8 6143.4 438.3 452.4 452.5 466.9 467.7 4065.6 4143.1 4151.4 4159.9 4204.1 10327.3 10594.3 10643.7 10766.3 10770.8 10602.9 10762.1 10779.5 10790.8 10899.0 7032.5 7391.7 8219.3 8317.2 8455.9 6036.0 6118.3 6154.0 6227.1 6303.5 9911.5 10060.1 10270.8 10374.3 10398.7 8774.6 10486.5 10515.1 10524.3 10562.2 6997.1 7315.5 7661.7 7670.9 7806.0 8373.5 8510.9 8557.8 8562.4 8570.4 7482.4 7562.3 7586.6 7637.0 7705.0 7391.4 7403.0 7448.7 7517.0 7571.5 6950.7 6994.8 7033.8 7039.7 7083.0 4978.7 5051.4 5055.0 5091.0 5165.7 3985.5 5159.6 5184.3 5189.0 5345.7 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4711.29 Median:5155.64 stddev:1492.43 (28.9%) stddev-sans-first:1459.66 12:38:18 INFO - PROCESS | 1650 | Values: 313.6 316.7 321.9 327.2 328.6 4692.4 5416.3 5471.9 5599.7 5651.5 5535.2 5553.3 5560.4 5573.7 5599.7 4215.4 4217.7 4219.7 4254.9 4256.1 4020.2 4204.2 4214.4 4247.6 4271.3 3465.8 4179.4 4188.8 4189.6 4202.0 3724.0 4023.3 4201.1 4241.7 4243.9 3038.8 3175.9 3671.9 3674.7 3681.8 4719.6 5175.6 5488.6 5500.5 5523.5 4791.3 4883.6 4888.0 4903.9 4907.6 5187.3 5629.8 5901.9 5926.0 5999.0 3642.6 3674.8 4053.7 4060.2 4072.3 5738.0 6216.9 6282.5 6294.2 6297.6 3607.0 3747.6 3841.5 4135.6 4138.3 3794.4 3878.4 4103.3 4113.1 4113.9 4199.3 4325.4 4781.5 4818.6 4830.9 5651.5 5988.6 6009.6 6022.5 6057.9 1227.6 1359.3 1396.8 1400.4 1406.7 794.7 834.6 835.4 846.9 862.9 4131.4 4612.8 4643.2 4666.0 4693.5 4641.3 5070.5 5135.6 5198.9 5226.9 4018.3 4252.9 4472.4 4511.8 4682.4 2990.7 3113.3 3307.7 3310.8 3319.6 5336.8 5511.1 5902.6 6401.7 6437.0 5687.0 6068.0 6322.8 6346.5 6409.8 6396.4 6414.1 6416.6 6465.6 6480.3 4842.5 5667.9 6181.2 6191.6 6193.2 4754.9 5831.8 5846.6 5937.1 6094.3 5547.0 5629.3 6080.8 6191.3 6450.8 3255.7 3870.5 3966.7 4041.7 4082.3 5964.4 6164.2 6201.8 6213.6 6258.2 4702.4 4975.5 5865.8 5966.6 5968.8 5129.9 5831.7 5979.6 5987.4 6041.3 5678.9 5737.6 5798.6 5822.3 5885.3 5619.0 5713.4 5926.7 5959.9 6015.8 5109.9 5527.7 5832.2 5861.7 5868.4 12:38:18 INFO - PROCESS | 1650 | 12:38:18 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:25440.72 Median:3588.68 stddev:40470.32 (1127.7%) stddev-sans-first:40541.40 12:38:18 INFO - PROCESS | 1650 | Values: 751.2 773.9 781.5 838.4 884.9 15449.8 15820.4 15968.4 15974.0 15988.0 14536.1 15764.8 16308.8 16361.6 16675.0 726.8 921.7 937.9 945.7 947.9 904.4 916.9 938.7 941.0 943.3 931.7 954.6 987.9 988.2 1000.5 925.3 942.9 976.8 980.9 982.3 688.5 721.2 729.5 739.1 743.2 15541.2 15629.7 15820.4 15874.3 15887.4 14107.6 14402.0 14488.3 14493.6 14541.0 8862.4 9968.9 10111.9 11562.9 12466.1 3897.1 3951.4 3969.4 4073.1 4096.9 94854.6 111737.0 113243.0 113543.4 116337.1 11281.1 11317.6 11431.3 11471.9 11871.1 22398.4 22404.3 22425.0 22449.6 22611.4 7896.5 8176.3 8231.8 8234.7 8317.9 4500.3 4524.4 4565.6 4591.4 4711.6 3139.3 3587.7 3589.6 3590.2 3591.0 606.5 643.0 646.0 659.2 663.2 509.7 678.7 691.4 700.5 704.7 8833.4 9117.5 9335.0 9487.8 9571.6 642.4 650.6 696.6 700.0 700.7 4413.5 4455.6 4513.5 4558.8 4626.6 140079.6 142399.0 146349.0 154969.0 156771.0 135239.0 138596.3 140133.0 140214.0 141040.0 101427.0 105060.0 105345.5 107003.4 109608.5 8707.2 8796.4 8800.2 8836.8 9006.2 64262.7 66179.4 66329.7 66874.7 66887.7 92668.5 97377.0 99572.0 100221.0 101745.5 9834.7 11693.8 11851.8 11955.7 12105.8 13244.3 14672.4 15343.8 15696.4 15704.2 14146.5 14203.7 14319.1 14663.9 14816.5 14159.1 14203.3 14221.4 14310.8 14532.9 13640.9 13716.9 13730.1 13974.0 14019.2 11232.9 11328.4 11744.2 11890.9 11896.5 11014.3 11526.0 11586.3 11598.6 11780.3 12:38:18 INFO - PROCESS | 1650 | -------- Summary: end -------- 12:38:18 INFO - PROCESS | 1650 | 12:38:19 INFO - TEST-INFO | 1650: exit 0 12:38:19 INFO - TEST-OK | dromaeo_css | took 1112512ms 12:38:19 INFO - TEST-START | kraken 12:38:19 INFO - operating with platform_type : mac_ 12:38:19 INFO - Initialising browser for kraken test... 12:38:19 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpZj_g5U/profile http://localhost:49279/getInfo.html) 12:38:22 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 12:38:22 INFO - PROCESS | 1662 | colorDepth:24 12:38:22 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 12:38:22 INFO - PROCESS | 1662 | __metrics 12:38:22 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:38:23 INFO - TEST-INFO | 1662: exit 0 12:38:23 INFO - Browser initialized. 12:38:23 INFO - Running cycle 1/1 for kraken test... 12:38:23 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpZj_g5U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:38:35 INFO - PROCESS | 1664 | RSS: Main: 254500864 12:38:35 INFO - PROCESS | 1664 | 12:38:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 12:38:39 INFO - PROCESS | 1664 | RSS: Main: 267497472 12:38:39 INFO - PROCESS | 1664 | 12:38:42 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 12:38:42 INFO - PROCESS | 1664 | RSS: Main: 272048128 12:38:42 INFO - PROCESS | 1664 | 12:38:46 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 12:38:47 INFO - PROCESS | 1664 | RSS: Main: 272457728 12:38:47 INFO - PROCESS | 1664 | 12:38:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 12:38:49 INFO - PROCESS | 1664 | RSS: Main: 273068032 12:38:49 INFO - PROCESS | 1664 | 12:38:51 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:38:52 INFO - PROCESS | 1664 | RSS: Main: 273584128 12:38:52 INFO - PROCESS | 1664 | 12:38:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 12:38:56 INFO - PROCESS | 1664 | RSS: Main: 274411520 12:38:56 INFO - PROCESS | 1664 | 12:38:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 12:38:59 INFO - PROCESS | 1664 | RSS: Main: 274649088 12:38:59 INFO - PROCESS | 1664 | 12:39:02 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 12:39:03 INFO - PROCESS | 1664 | RSS: Main: 274771968 12:39:03 INFO - PROCESS | 1664 | 12:39:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:39:05 INFO - PROCESS | 1664 | RSS: Main: 274530304 12:39:05 INFO - PROCESS | 1664 | 12:39:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:39:08 INFO - PROCESS | 1664 | RSS: Main: 274038784 12:39:08 INFO - PROCESS | 1664 | 12:39:10 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:39:11 INFO - PROCESS | 1664 | RSS: Main: 274452480 12:39:11 INFO - PROCESS | 1664 | 12:39:13 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:39:14 INFO - PROCESS | 1664 | RSS: Main: 274698240 12:39:14 INFO - PROCESS | 1664 | 12:39:17 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:39:18 INFO - PROCESS | 1664 | RSS: Main: 274468864 12:39:18 INFO - PROCESS | 1664 | 12:39:19 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 12:39:20 INFO - PROCESS | 1664 | RSS: Main: 275337216 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | __start_tp_report 12:39:20 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 12:39:20 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 12:39:20 INFO - PROCESS | 1664 | |i|pagename|runs| 12:39:20 INFO - PROCESS | 1664 | |0;ai-astar;127;170;84;167;174;168;92;96;171;117 12:39:20 INFO - PROCESS | 1664 | |1;audio-beat-detection;144;109;134;181;97;127;154;144;199;113 12:39:20 INFO - PROCESS | 1664 | |2;audio-dft;205;254;282;188;280;277;196;197;194;196 12:39:20 INFO - PROCESS | 1664 | |3;audio-fft;71;78;76;140;58;57;60;74;154;80 12:39:20 INFO - PROCESS | 1664 | |4;audio-oscillator;70;74;121;81;93;105;147;91;74;112 12:39:20 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;90;136;128;90;125;99;85;88;86 12:39:20 INFO - PROCESS | 1664 | |6;imaging-darkroom;94;94;95;97;97;94;117;112;150;118 12:39:20 INFO - PROCESS | 1664 | |7;imaging-desaturate;89;92;101;143;91;90;91;90;102;149 12:39:20 INFO - PROCESS | 1664 | |8;json-parse-financial;56;55;55;56;56;55;54;53;54;57 12:39:20 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;67;70;68;70;77;73;75;75;78;71 12:39:20 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;87;87;87;85;87;83;86;89;86;119 12:39:20 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;144;153;162;151;150;143;150;150;167;157 12:39:20 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;164;161;166;173;174;237;168;165;162;170 12:39:20 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;68;68;69;68;66;67;64;68;66;67 12:39:20 INFO - PROCESS | 1664 | __end_tp_report 12:39:20 INFO - PROCESS | 1664 | __start_cc_report 12:39:20 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,1132 12:39:20 INFO - PROCESS | 1664 | __end_cc_report 12:39:20 INFO - PROCESS | 1664 | __startTimestamp1468957160088__endTimestamp 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | ------- Summary: start ------- 12:39:20 INFO - PROCESS | 1664 | Number of tests: 14 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:136.60 Median:172.50 stddev:37.25 (21.6%) stddev-sans-first:39.35 12:39:20 INFO - PROCESS | 1664 | Values: 127.0 170.0 84.0 167.0 174.0 168.0 92.0 96.0 171.0 117.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:149.00 stddev:31.86 (21.4%) stddev-sans-first:33.76 12:39:20 INFO - PROCESS | 1664 | Values: 144.0 109.0 134.0 181.0 97.0 127.0 154.0 144.0 199.0 113.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:226.90 Median:229.50 stddev:40.80 (17.8%) stddev-sans-first:42.49 12:39:20 INFO - PROCESS | 1664 | Values: 205.0 254.0 282.0 188.0 280.0 277.0 196.0 197.0 194.0 196.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:84.80 Median:72.50 stddev:33.99 (46.9%) stddev-sans-first:35.68 12:39:20 INFO - PROCESS | 1664 | Values: 71.0 78.0 76.0 140.0 58.0 57.0 60.0 74.0 154.0 80.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:74.00 stddev:24.63 (33.3%) stddev-sans-first:24.14 12:39:20 INFO - PROCESS | 1664 | Values: 70.0 74.0 121.0 81.0 93.0 105.0 147.0 91.0 74.0 112.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:101.50 Median:88.00 stddev:19.98 (22.7%) stddev-sans-first:20.59 12:39:20 INFO - PROCESS | 1664 | Values: 88.0 90.0 136.0 128.0 90.0 125.0 99.0 85.0 88.0 86.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:106.80 Median:94.00 stddev:18.09 (19.2%) stddev-sans-first:18.59 12:39:20 INFO - PROCESS | 1664 | Values: 94.0 94.0 95.0 97.0 97.0 94.0 117.0 112.0 150.0 118.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:90.00 stddev:22.75 (25.3%) stddev-sans-first:23.49 12:39:20 INFO - PROCESS | 1664 | Values: 89.0 92.0 101.0 143.0 91.0 90.0 91.0 90.0 102.0 149.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.20 (2.2%) stddev-sans-first:1.22 12:39:20 INFO - PROCESS | 1664 | Values: 56.0 55.0 55.0 56.0 56.0 55.0 54.0 53.0 54.0 57.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:74.00 stddev:3.78 (5.1%) stddev-sans-first:3.46 12:39:20 INFO - PROCESS | 1664 | Values: 67.0 70.0 68.0 70.0 77.0 73.0 75.0 75.0 78.0 71.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:87.00 stddev:10.45 (12.0%) stddev-sans-first:11.04 12:39:20 INFO - PROCESS | 1664 | Values: 87.0 87.0 87.0 85.0 87.0 83.0 86.0 89.0 86.0 119.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:152.70 Median:152.00 stddev:7.48 (4.9%) stddev-sans-first:7.25 12:39:20 INFO - PROCESS | 1664 | Values: 144.0 153.0 162.0 151.0 150.0 143.0 150.0 150.0 167.0 157.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:169.00 stddev:22.56 (13.3%) stddev-sans-first:23.63 12:39:20 INFO - PROCESS | 1664 | Values: 164.0 161.0 166.0 173.0 174.0 237.0 168.0 165.0 162.0 170.0 12:39:20 INFO - PROCESS | 1664 | 12:39:20 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:1.45 (2.1%) stddev-sans-first:1.50 12:39:20 INFO - PROCESS | 1664 | Values: 68.0 68.0 69.0 68.0 66.0 67.0 64.0 68.0 66.0 67.0 12:39:20 INFO - PROCESS | 1664 | -------- Summary: end -------- 12:39:20 INFO - PROCESS | 1664 | 12:39:21 INFO - TEST-INFO | 1664: exit 0 12:39:21 INFO - TEST-OK | kraken | took 61657ms 12:39:21 INFO - SUITE-END | took 1174s 12:39:21 INFO - Completed test suite (00:19:34) 12:39:21 INFO - javascript benchmark 12:39:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7368.830566428745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.8910488132915, 3363.663633636636, 3374.0552645259336, 3406.1654894550825, 3417.436123039697, 5742.167385729072, 5790.68151251681, 5800.970995145029, 5830.650160990333, 5870.970645146779, 4407.867763967086, 5641.18202860585, 5776.451237132465, 5818.941810581893, 5833.708314584275, 5185.714785686786, 5245.423003469616, 5335.706536140511, 5375.596830237729, 5402.35171779385, 456.56232244798576, 5313.203019547061, 5316.0962636351915, 5332.173513105475, 5402.8919421611545, 5256.842294731164, 5271.446498117681, 5279.9440111977565, 5299.708516031616, 5309.203619457112, 5219.451957544441, 5317.654352467077, 5338.706371149585, 5345.144776835727, 5347.037533244014, 5218.765155568009, 5231.581473482151, 5254.789808407659, 5272.815451459181, 5284.154535274338, 5770.682612456313, 5848.766049358021, 5864.648121112704, 5876.2067120938555, 5901.203337549418, 6152.538559608002, 6213.042891489166, 6218.28489723683, 6297.464715499188, 6306.1171435998995, 6256.718447669866, 6263.060540918898, 6271.498280137578, 6280.968595157041, 6281.937180628227, 5942.168096466498, 5944.108383742387, 5955.5074543134615, 5969.61197522164, 6008.339082700856, 6189.133521307021, 6228.439440450381, 6295.087212354183, 6322.462590679752, 6370.362963703686, 6184.752609895644, 6246.406591373812, 6253.062040693932, 6262.5929314594405, 6271.027990661455, 6161.815145545641, 6264.091706702503, 6281.183446151971, 6285.962816135287, 6298.968505157445, 6131.448169664752, 6194.4115309045565, 6236.937630623726, 6260.40526150015, 6280.591761535486, 5275.340582427197, 6107.735039974563, 6186.257649082049, 6251.687415629201, 6266.780662676875, 4060.842659841931, 4337.414449049401, 4566.703164294377, 4885.2427873679635, 4993.375828021497, 4431.889202769957, 4441.555844415597, 4452.0873220989615, 4462.464504259509, 4493.191225579361, 5523.944760552424, 5648.858778530487, 6053.4854537363935, 6056.818295451144, 6073.210482637229, 5305.814296499604, 6270.2789179244055, 6285.811425657238, 6290.528210384239, 6316.905246421307, 5781.768729250867, 5938.49522790559, 5973.522118230531, 6003.5797494174985, 6037.275526936708, 5498.697571633518, 5502.779888804483, 5519.558435325164, 5523.917141242885, 5537.141743029837, 6180.134781130555, 6383.616982981036, 6385.201849768686, 6406.167198264196, 6415.230172379251, 6206.534509911684, 6212.161358216764, 6248.281447633581, 6256.687165641609, 6287.591306565058, 6396.488280937607, 6401.391867772554, 6413.262474815456, 6427.839304017437, 6432.549721519449, 5982.52139828804, 6189.164462797645, 6290.842728931813, 6292.559520833498, 6297.811065668037, 6197.659128747782, 6230.0, 6265.749370025148, 6294.937050629435, 6299.622022678654, 5973.074173503114, 6078.817635470943, 6262.749490020348, 6281.623102613858, 6286.119943208046, 6100.969495152496, 6128.380904898417, 6171.352008039091, 6242.53181011435, 6307.085472606538, 5888.0, 5900.996830538733, 5990.371011043778, 6028.306744724237, 6143.508519318533, 6162.260528736401, 6181.5363847710705, 6197.194364732556, 6210.378962103753, 6214.974529202631, 5926.911096333472, 6045.002574575145, 6045.486133678686, 6115.694215289129, 6132.693365331805], "value": 5708.9069067132195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.5296203619073, 510.68082448469704, 526.8814516733735, 551.2255281329732, 592.6207227374484, 39464.2107157857, 42175.15649687005, 42187.78906105465, 42252.788736056275, 42442.57557424425, 42696.57303426965, 42747.57252427475, 43356.699299021, 43379.56620433803, 43391.78304108475, 9779.168770654504, 9951.502424878763, 9960.352577082504, 9977.15194208493, 9996.700098997042, 9430.717078487656, 9815.901840981605, 9852.556634951445, 9929.801403971916, 9958.402495850236, 9912.0, 9922.851157232648, 9944.204463642927, 9951.601935922554, 9998.150157236607, 9879.209663226924, 9929.602815887356, 9932.652357167537, 9951.80096398068, 9959.502024898726, 9679.564419601065, 9681.0, 9696.030396960317, 9742.0, 9823.557939892722, 40464.79767601143, 40890.0, 41007.0, 41469.792651036856, 41578.79210603928, 3045.8629361678777, 3258.657840926716, 3332.5501057357433, 3468.0982944434377, 3495.73781966351, 29677.109686709435, 31074.689253107405, 31233.687663123306, 31772.20569485758, 32006.0, 2633.2363614551755, 2768.3632764464087, 3202.7277681396877, 3228.1122691259857, 3351.0, 439468.0, 441743.0, 443506.0, 443575.0, 444378.0, 28216.576751348744, 32932.0, 33643.15892102717, 34221.48667769985, 35115.0, 35161.824190878884, 35402.0, 35467.0, 35570.28859422797, 35639.0, 14552.563423097325, 14790.0, 14970.026948248547, 14979.850201498064, 15025.248737563079, 12350.38248087592, 12556.372181390894, 12624.747505049847, 12663.936680316723, 12708.919741821865, 6485.967570162214, 7572.5835079070075, 7620.5808680523105, 7636.350910172698, 7738.535687858746, 3177.9682203178136, 3212.2772376215166, 3222.6777322267585, 3229.3379857129703, 3239.0606724049762, 936.6581197862868, 976.2677991506371, 1006.2905651515664, 1006.3408467453829, 1055.7307886488895, 31329.530057049164, 31386.21534461611, 31568.0, 31675.841620791747, 31717.524237136462, 1094.5895289266525, 1099.219554116586, 1099.5656715597295, 1163.2962057954985, 1168.4800263882491, 13801.309934503235, 16270.83729162717, 16273.860829742041, 16402.507924762278, 16753.748693769605, 417142.0, 484528.0, 485965.0, 487164.0, 488454.0, 47244.0, 51407.22889156666, 60784.696076519336, 61359.0, 62226.0, 1378.0216046607022, 1418.44680574576, 1424.7008128293176, 1429.2353590828857, 1434.8565143485569, 26761.929522818868, 30116.548251775803, 30832.845835770677, 30837.074887753402, 31020.0, 48406.5159348402, 48688.75655621699, 48822.511774881794, 49185.754071229414, 49276.75361623169, 486161.0, 488184.0, 488757.11242887116, 489334.0, 489475.0, 27256.72743272542, 27622.585661214696, 27714.307142321602, 27993.720062799926, 28652.42695146127, 50332.74833625808, 50356.24465632945, 50901.0, 51073.23390149076, 51521.0, 40380.0, 41781.0, 41865.0, 42859.928501787705, 42899.5710042908, 41394.172116556896, 41986.0, 42299.57700422956, 42454.5754542463, 42667.78666106649, 38788.6121138785, 39188.0, 40338.596614033486, 40390.59609403869, 40408.59591404048, 34510.827445863615, 35640.82179589086, 36266.0, 36671.81664091662, 36859.07852303714, 21614.0, 26212.082577109708, 26229.606555901297, 26735.86632066905, 27089.593656095567], "value": 18434.39965558995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.73729126902435, 384.37538999126417, 390.44343218369437, 392.30561905427396, 409.3838772647167, 15080.773788393182, 16103.91948040261, 16319.69442444603, 19175.52061198469, 20004.799952000474, 20658.586828263426, 20934.685979710277, 20994.790052099474, 21791.564168716617, 22076.22733204338, 5579.8605034874045, 5931.73307201177, 5942.940570594282, 6073.60521566099, 6250.093736408218, 5264.552513036397, 5900.321463031742, 5998.0, 6014.8195554133445, 6041.879162416749, 5980.10298455233, 5983.072623743326, 5999.910001349961, 6100.908486372708, 6123.755049798025, 5213.817516386908, 6015.097735339712, 6113.113598528211, 6125.877482450348, 6153.846153846145, 5879.0, 5907.9704601476715, 5917.408259174092, 5938.970305148447, 5957.702114894281, 25909.870450647813, 26315.868420657775, 26755.46489070227, 26831.060912867957, 26913.327166820985, 2192.48476607997, 2511.5604769165507, 2694.986525067362, 2880.2367372646268, 2982.3140677644265, 9769.951150244275, 10289.639862604849, 10307.278490505667, 10440.269181157322, 10517.63188288414, 1920.2798950393603, 1925.0855843474378, 1932.792004996877, 1964.9705254421194, 1974.3780709076595, 128350.35824820815, 134499.6550034497, 135300.0, 135485.3225733875, 135571.32214338865, 9325.953370233241, 11234.0, 11415.258008229439, 11716.355600441888, 11774.0, 14637.560873173821, 14684.559463216121, 14693.412263509339, 14720.337584808709, 14742.631434214016, 7062.646867656596, 7252.0, 8607.18231767981, 8765.868511972325, 8769.079246679006, 8667.133286671282, 8675.91324086751, 8677.088905664941, 8777.780555486164, 8790.91209087901, 3744.7565908216425, 4491.528389519119, 4523.638108951276, 4559.974005848658, 4614.238650622677, 1918.3861164427528, 1948.9025548722507, 1958.6180694764384, 2004.83961283097, 2010.1456880825883, 766.6779952419997, 862.4092496639822, 901.1439132823843, 921.2721949659827, 922.4787994783061, 20774.0, 21360.78639213619, 21444.892775536333, 21463.0, 21499.355019349445, 945.2154711589365, 976.2677991506371, 1007.2848277722899, 1029.6910926721953, 1032.8554002439664, 8588.527630980356, 11371.601993930173, 11373.715657108638, 11390.202685811913, 11446.713832154262, 634639.0, 635400.6459935341, 636079.0, 644688.0, 646861.0, 101816.0, 138119.56923876697, 143688.0, 149370.0, 149970.25014875075, 816.1675091406731, 1025.0671888581205, 1029.0738335497963, 1033.2973577967055, 1039.2205845615788, 19679.31122410709, 19839.60320793605, 20374.28689995843, 20604.58790824205, 21533.569328613652, 57819.0, 58462.7076864613, 59837.70081149566, 60036.09945850903, 60589.394106058375, 79774.60112699399, 80222.5988870052, 80641.3871722574, 81120.0, 83367.16632833594, 8265.421420500748, 8346.707865224687, 8371.581420928807, 8440.535770532433, 8558.400911936355, 11493.54025838957, 13358.799618005543, 13534.323283835965, 13642.454301828213, 13677.589672309847, 11493.82759258595, 11624.0, 11710.824337635113, 11720.0, 11726.00328972047, 11343.035841953526, 11389.601363952223, 11462.713432164262, 11588.710282243012, 11746.884046015615, 11374.601888933848, 11718.589849355572, 11797.410129493663, 11911.047116230508, 12112.454939527566, 8252.669893204205, 8299.087100418828, 8371.748847534584, 8510.021347545111, 8586.398952073296, 9313.34806563534, 10375.896241037493, 10876.293040952629, 10987.450627468435, 11048.779024419628], "value": 9823.452388114792, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1559.9626248544719, 1593.2670971353177, 1826.835584797368, 1916.942491725248, 1935.080836602613, 7429.36850367718, 8582.098879617628, 8633.395662303641, 8698.217160455566, 9173.0, 7552.8867066994035, 8805.64777408903, 8855.734327970154, 8941.91058089419, 8947.060558641346, 2275.306031660343, 2295.8737269450176, 2362.4802543440414, 2391.9714522755207, 2395.6765836612008, 2362.492064206204, 2383.0348708772976, 2391.701037370329, 2404.9398765030837, 2407.9398015049587, 2055.3114706573315, 2380.4762952150586, 2380.9880950595225, 2383.1420688552107, 2404.8196385271085, 2303.0787684925995, 2376.5603363377745, 2386.033656369173, 2388.8208384371155, 2391.7249516305587, 2345.425370784169, 2346.249200255919, 2371.2412028150998, 2371.4071482129466, 2389.1279682915783, 8954.86567701485, 9025.864612030824, 9025.909740902573, 9027.909720902773, 9047.050059743764, 5201.55786758126, 5317.229001794718, 5335.946640533583, 5355.0896347621, 5424.484673955968, 3492.161881148506, 3495.545579074704, 3557.1107223194203, 3566.4828599852876, 3569.321828852536, 1078.95684172633, 1084.3060441317564, 1091.8689757229183, 1104.917131215162, 1109.2845114900924, 11446.370449625267, 11583.478743456564, 11627.12796540263, 11632.069434445224, 11646.126540509411, 4571.885702857455, 4583.54164583539, 4742.359781429463, 4747.8575642730775, 4801.351817504592, 9905.653302134535, 9927.156191723785, 9929.652462163935, 9937.205023598095, 10001.549930253155, 5333.280007198979, 5339.199120132012, 5344.278522399504, 5344.599155063386, 5374.5700343972385, 4359.651227901823, 4768.809247630056, 4903.239997800347, 4910.533499317559, 4927.0, 3289.605247370283, 3489.2149266415363, 3685.6867166291167, 4061.634452899253, 4082.408050832613, 1299.2074834351038, 1312.5930961401996, 1313.8883194928346, 1316.2431601828987, 1340.1021315718492, 949.8432758594754, 951.357833462424, 952.3571589177278, 975.3757595139117, 1004.1549523548906, 5249.107651699221, 5974.820755377345, 5988.101784732238, 6070.7875224366935, 6143.354947730513, 438.283406630162, 452.40734637624814, 452.47738861614886, 466.89494863656085, 467.66094581428194, 4065.593440655911, 4143.109231515239, 4151.418801367811, 4159.854405095807, 4204.07510347723, 10327.277090603737, 10594.258401911946, 10643.733906652396, 10766.300190487593, 10770.78458430827, 10602.893971060344, 10762.085222755997, 10779.461026948622, 10790.838137427787, 10899.0, 7032.507724459341, 7391.669499490144, 8219.260266576037, 8317.168283171635, 8455.873161902577, 6035.969820151046, 6118.326984031664, 6153.969230153821, 6227.097070924781, 6303.46420554258, 9911.45486998222, 10060.144887684628, 10270.845937310796, 10374.325668831803, 10398.68803935883, 8774.605142768718, 10486.47567621631, 10515.106215971728, 10524.31591946521, 10562.155027597928, 6997.090378250795, 7315.451341149329, 7661.693532258647, 7670.884936725842, 7806.0, 8373.455725377831, 8510.914890851012, 8557.828843423222, 8562.357823163413, 8570.357223208159, 7482.401407887247, 7562.281583249583, 7586.582737949245, 7637.007189065386, 7704.961475192588, 7391.40868730511, 7403.0, 7448.702051917862, 7516.962415187889, 7571.507851989603, 6950.687219075053, 6994.790156295319, 7033.788986330418, 7039.6832142552685, 7083.0, 4978.726170060681, 5051.419086805065, 5055.014272216882, 5091.0, 5165.741712914414, 3985.4619626350072, 5159.613029022763, 5184.300119483822, 5188.988147311238, 5345.705986170798], "value": 4545.601739073647, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.55788338442784, 316.65326467518065, 321.91308346746376, 327.22284574136427, 328.60567319216943, 4692.389989301386, 5416.322959630046, 5471.890562188763, 5599.692016939067, 5651.463111004453, 5535.169724541321, 5553.305836770403, 5560.387487628583, 5573.749181286842, 5599.664020158793, 4215.388768628547, 4217.704760666755, 4219.725717828339, 4254.893627659302, 4256.148770245948, 4020.2160578687167, 4204.2432362174795, 4214.367844823286, 4247.575242475743, 4271.287732289987, 3465.826708664569, 4179.435776170224, 4188.81150348235, 4189.622933935945, 4201.953583651859, 3724.0262660789826, 4023.2959232134554, 4201.138766552849, 4241.6818738594575, 4243.936340954888, 3038.787284890059, 3175.904722858318, 3671.889843304705, 3674.7243956703355, 3681.7790932544135, 4719.551642593982, 5175.637705360627, 5488.643238189505, 5500.50495455407, 5523.530499907512, 4791.329213910055, 4883.584895283905, 4888.0468308679465, 4903.901921961541, 4907.558319751204, 5187.325647665817, 5629.774809007635, 5901.8819623607715, 5926.0, 5999.0, 3642.6357364263363, 3674.8346324415465, 4053.6959728020515, 4060.2488539620263, 4072.348424252135, 5737.991702903992, 6216.880961426941, 6282.497400208018, 6294.213223347082, 6297.622142671455, 3606.972012976289, 3747.606501317377, 3841.501814292428, 4135.627793498599, 4138.255114079434, 3794.449804778347, 3878.4376265441915, 4103.322951712994, 4113.074558224375, 4113.938290925638, 4199.265128602482, 4325.3728209409455, 4781.517729503865, 4818.590419814355, 4830.903381932341, 5651.491365777099, 5988.610740301867, 6009.639421634629, 6022.5483088768515, 6057.878842423215, 1227.5642147037852, 1359.2872980045215, 1396.84634690184, 1400.4188261871413, 1406.6694326833185, 794.654325368455, 834.5701963488808, 835.4402550291198, 846.9153084691604, 862.9439086459486, 4131.35963925592, 4612.792424340845, 4643.233866412072, 4665.953340466552, 4693.5071817458675, 4641.327007583882, 5070.518300761421, 5135.6405051646025, 5198.906650542921, 5226.947730522722, 4018.3369743991916, 4252.851150209728, 4472.44094488189, 4511.834319526645, 4682.41469816273, 2990.7308342249303, 3113.2683819302447, 3307.7353811695007, 3310.8013519188926, 3319.5850518685165, 5336.813211537577, 5511.090670039479, 5902.586818922634, 6401.711922963478, 6437.0, 5687.004774164505, 6068.0, 6322.841928951813, 6346.492280617539, 6409.8077057687415, 6396.392342727433, 6414.1340918976275, 6416.647084410402, 6465.612063276219, 6480.347511384661, 4842.491538388418, 5667.943320566742, 6181.196444462191, 6191.628502289877, 6193.163922870535, 4754.904901902012, 5831.82504524848, 5846.649201047951, 5937.109433584824, 6094.268687757321, 5547.029269877836, 5629.339344893348, 6080.787172448943, 6191.349908259568, 6450.774222902176, 3255.723263522627, 3870.5161854768153, 3966.6826653868197, 4041.6766658666647, 4082.3468245080644, 5964.403559644001, 6164.167837342081, 6201.81394558164, 6213.596116252429, 6258.249010118815, 4702.401183597456, 4975.477574854733, 5865.765369385347, 5966.612170208922, 5968.820935371946, 5129.923051154161, 5831.717022255267, 5979.594795223032, 5987.43119403656, 6041.305249896318, 5678.943210568007, 5737.627054241461, 5798.5646028667215, 5822.3304320003745, 5885.323187833283, 5619.0, 5713.400092990176, 5926.67403292823, 5959.880802384015, 6015.759369625341, 5109.923351149661, 5527.668339899458, 5832.154337621106, 5861.710423706778, 5868.354481007171], "value": 4232.450101928372, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [751.2037240525043, 773.9187385324537, 781.5193655901622, 838.3754103193122, 884.8584226523758, 15449.845501544982, 15820.367185312602, 15968.361265549363, 15974.0, 15988.04071755694, 14536.127832330041, 15764.763528547051, 16308.83691163088, 16361.590960226, 16675.0, 726.7601691441812, 921.6866265469756, 937.929655275857, 945.7399215215836, 947.9004704505996, 904.4392476664477, 916.9403988740711, 938.713692323841, 941.0, 943.2925306020485, 931.7204838548442, 954.5704433005176, 987.8518222266681, 988.2341185581196, 1000.5297510170209, 925.2597921662676, 942.8915674697395, 976.8485884687884, 980.8577756225379, 982.3418309732425, 688.50771698236, 721.1634503975364, 729.5476804381318, 739.1389031777973, 743.1528058013869, 15541.222938853125, 15629.687406251925, 15820.446284380107, 15874.285657145456, 15887.443939462179, 14107.576772696835, 14402.0, 14488.275586220647, 14493.56519304412, 14540.982131250817, 8862.42394244372, 9968.850467242997, 10111.89888101117, 11562.884371156264, 12466.127371084027, 3897.142628621699, 3951.38753493209, 3969.3649016157565, 4073.06319546503, 4096.897577560555, 94854.628634284, 111737.0, 113243.0, 113543.43228283888, 116337.09157271136, 11281.074558998016, 11317.603883864025, 11431.256968297033, 11471.942640286912, 11871.0503159747, 22398.440038999157, 22404.32787016392, 22425.0, 22449.551008980055, 22611.43471413228, 7896.486728362638, 8176.264136227649, 8231.794205144919, 8234.711785087493, 8317.875231871527, 4500.279955207151, 4524.366588677588, 4565.56627120423, 4591.403117594758, 4711.575958163782, 3139.293658926769, 3587.712982961357, 3589.6410358963894, 3590.2460483298278, 3591.030421786103, 606.4572207873928, 642.9710663020176, 645.9515536334794, 659.2484567592948, 663.2174034639075, 509.66362200947196, 678.7081554931328, 691.4192078653955, 700.4851434195862, 704.7427688893517, 8833.425827321204, 9117.498537580364, 9334.953325233466, 9487.76280592977, 9571.61713531451, 642.392938672959, 650.5998810731461, 696.6238231355012, 699.989500157498, 700.7162099349772, 4413.514513403523, 4455.554444555583, 4513.480949690827, 4558.772061396917, 4626.629869610423, 140079.5992040087, 142399.0, 146349.0, 154969.0, 156771.0, 135239.0, 138596.30701846626, 140133.0, 140214.0, 141040.0, 101427.0, 105060.0, 105345.47327263314, 107003.39494907582, 109608.4519577413, 8707.172818582225, 8796.384253102222, 8800.207981281716, 8836.823263534821, 9006.189442950166, 64262.67868660627, 66179.35282588835, 66329.66835165986, 66874.66562667156, 66887.66556167188, 92668.53665731628, 97377.0262297368, 99572.0, 100221.0, 101745.49127254612, 9834.704958851245, 11693.76612467763, 11851.762964740828, 11955.701107472383, 12105.81841272364, 13244.337783111, 14672.37313994765, 15343.846561534241, 15696.372145114068, 15704.214789260719, 14146.504872329419, 14203.715925681636, 14319.069260498034, 14663.92668036653, 14816.48142315057, 14159.079659822079, 14203.28983550839, 14221.360038798071, 14310.785338220143, 14532.927335363256, 13640.931795340959, 13716.908890847453, 13730.107543009672, 13974.0, 14019.158850469004, 11232.871243649997, 11328.433578321215, 11744.236624619372, 11890.940545297219, 11896.464659090534, 11014.339139651647, 11526.0, 11586.304821710388, 11598.594049208237, 11780.293182409083], "value": 8048.589341735753, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1608.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 170.0, 84.0, 167.0, 174.0, 168.0, 92.0, 96.0, 171.0, 117.0], "value": 136.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 109.0, 134.0, 181.0, 97.0, 127.0, 154.0, 144.0, 199.0, 113.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 254.0, 282.0, 188.0, 280.0, 277.0, 196.0, 197.0, 194.0, 196.0], "value": 226.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 76.0, 140.0, 58.0, 57.0, 60.0, 74.0, 154.0, 80.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 121.0, 81.0, 93.0, 105.0, 147.0, 91.0, 74.0, 112.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 136.0, 128.0, 90.0, 125.0, 99.0, 85.0, 88.0, 86.0], "value": 101.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 97.0, 97.0, 94.0, 117.0, 112.0, 150.0, 118.0], "value": 106.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 101.0, 143.0, 91.0, 90.0, 91.0, 90.0, 102.0, 149.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 54.0, 53.0, 54.0, 57.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 68.0, 70.0, 77.0, 73.0, 75.0, 75.0, 78.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 85.0, 87.0, 83.0, 86.0, 89.0, 86.0, 119.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 153.0, 162.0, 151.0, 150.0, 143.0, 150.0, 150.0, 167.0, 157.0], "value": 152.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 166.0, 173.0, 174.0, 237.0, 168.0, 165.0, 162.0, 170.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 68.0, 66.0, 67.0, 64.0, 68.0, 66.0, 67.0], "value": 67.1, "unit": "score"}]}]} 12:39:21 INFO - Return code: 0 12:39:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:39:21 ERROR - # TBPL SUCCESS # 12:39:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:39:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:39:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:39:21 INFO - 2016-07-19 12:39:21.432 screenresolution[1669:10525] starting screenresolution argv=screenresolution get 12:39:21 INFO - 2016-07-19 12:39:21.436 screenresolution[1669:10525] Display 0: 1600x1200x32@60 12:39:21 INFO - 2016-07-19 12:39:21.442 screenresolution[1670:10528] starting screenresolution argv=screenresolution list 12:39:21 INFO - Available Modes on Display 0 12:39:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:39:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:39:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:39:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:39:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:39:21 INFO - Intel Iris: 12:39:21 INFO - Chipset Model: Intel Iris 12:39:21 INFO - Type: GPU 12:39:21 INFO - Bus: Built-In 12:39:21 INFO - VRAM (Dynamic, Max): 1536 MB 12:39:21 INFO - Vendor: Intel (0x8086) 12:39:21 INFO - Device ID: 0x0a2e 12:39:21 INFO - Revision ID: 0x0009 12:39:21 INFO - Displays: 12:39:21 INFO - Display: 12:39:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:39:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:39:21 INFO - Display Serial Number: 1600x1200 60 12:39:21 INFO - Main Display: Yes 12:39:21 INFO - Mirror: Off 12:39:21 INFO - Online: Yes 12:39:21 INFO - Rotation: Supported 12:39:21 INFO - Return code: 0 12:39:21 INFO - Running post-action listener: _resource_record_post_action 12:39:21 INFO - ##### 12:39:21 INFO - ##### Finished run-tests step (success) 12:39:21 INFO - ##### 12:39:21 INFO - Running post-run listener: _resource_record_post_run 12:39:21 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37127168; Write bytes: 707686400; Read time: 242; Write time: 1989 12:39:21 INFO - TinderboxPrint: CPU usage
54.2% 12:39:21 INFO - TinderboxPrint: I/O read bytes / time
37,127,168 / 242 12:39:21 INFO - TinderboxPrint: I/O write bytes / time
707,686,400 / 1,989 12:39:21 INFO - TinderboxPrint: CPU idle
2,215.9 (45.8%) 12:39:21 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 12:39:21 INFO - TinderboxPrint: CPU user
1,652.2 (34.2%) 12:39:21 INFO - TinderboxPrint: Swap in / out
444,850,176 / 0 12:39:21 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 403755520; Write bytes: 397665792; Read time: 29658; Write time: 838 12:39:21 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 34931712; Write bytes: 296311296; Read time: 218; Write time: 1113 12:39:22 INFO - Running post-run listener: _upload_blobber_files 12:39:22 INFO - Blob upload gear active. 12:39:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:39:22 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:39:22 INFO - (blobuploader) - INFO - Open directory for files ... 12:39:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:39:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:39:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:23 INFO - (blobuploader) - INFO - Done attempting. 12:39:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:39:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:39:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:24 INFO - (blobuploader) - INFO - Done attempting. 12:39:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:39:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:39:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:39:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:39:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:39:27 INFO - (blobuploader) - INFO - Done attempting. 12:39:27 INFO - (blobuploader) - INFO - Iteration through files over. 12:39:27 INFO - Return code: 0 12:39:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:39:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:39:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4caf41a0e033f91b521d5f716160dfefa174ce8df9ccdf1102888fda066c204e15661073fba35a5b0604d5483e5084d7839d4979974d0d073fc24901233e904b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c15979eddbb0720ccf6f57a317859f5b284cc1847a62521d79ab484c082a02f06ef7b5b786459857a166810f4ba328e7e5d6aa59bd6ac722fa665d1d3bc1bb9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/813209ee5310436634c23bd90950d726c79f554a65e0c3fae641ddf4dd789e4376659650a0f2364fe89f4a3fea96050e8819d2903ee5f785bb10c26bcfdb4ad1"} 12:39:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:39:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:39:27 INFO - Contents: 12:39:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4caf41a0e033f91b521d5f716160dfefa174ce8df9ccdf1102888fda066c204e15661073fba35a5b0604d5483e5084d7839d4979974d0d073fc24901233e904b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c15979eddbb0720ccf6f57a317859f5b284cc1847a62521d79ab484c082a02f06ef7b5b786459857a166810f4ba328e7e5d6aa59bd6ac722fa665d1d3bc1bb9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/813209ee5310436634c23bd90950d726c79f554a65e0c3fae641ddf4dd789e4376659650a0f2364fe89f4a3fea96050e8819d2903ee5f785bb10c26bcfdb4ad1"} 12:39:27 INFO - Running post-run listener: copy_logs_to_upload_dir 12:39:27 INFO - Copying logs to upload dir... 12:39:27 INFO - mkdir: /builds/slave/test/build/upload/logs 12:39:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.901798 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-19 12:39:27.985685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 12:39:27.989247) ========= 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.gwGBVQYcSK/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.yiEsejjI99/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4caf41a0e033f91b521d5f716160dfefa174ce8df9ccdf1102888fda066c204e15661073fba35a5b0604d5483e5084d7839d4979974d0d073fc24901233e904b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c15979eddbb0720ccf6f57a317859f5b284cc1847a62521d79ab484c082a02f06ef7b5b786459857a166810f4ba328e7e5d6aa59bd6ac722fa665d1d3bc1bb9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/813209ee5310436634c23bd90950d726c79f554a65e0c3fae641ddf4dd789e4376659650a0f2364fe89f4a3fea96050e8819d2903ee5f785bb10c26bcfdb4ad1"} build_url:https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010654 build_url: 'https://queue.taskcluster.net/v1/task/XVM5Tw64S22h9MftFVVydQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4caf41a0e033f91b521d5f716160dfefa174ce8df9ccdf1102888fda066c204e15661073fba35a5b0604d5483e5084d7839d4979974d0d073fc24901233e904b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c15979eddbb0720ccf6f57a317859f5b284cc1847a62521d79ab484c082a02f06ef7b5b786459857a166810f4ba328e7e5d6aa59bd6ac722fa665d1d3bc1bb9f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/813209ee5310436634c23bd90950d726c79f554a65e0c3fae641ddf4dd789e4376659650a0f2364fe89f4a3fea96050e8819d2903ee5f785bb10c26bcfdb4ad1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 12:39:28.021261) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:39:28.021619) ========= 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.gwGBVQYcSK/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.yiEsejjI99/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.004929 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 12:39:28.070902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 12:39:28.071239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 12:39:28.071587) ========= ========= Total master_lag: 0.56 =========