builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0099 starttime: 1468281440.79 results: success (0) buildid: 20160711145925 builduid: 98ddb434f26246dc9baef6c53f31d313 revision: 75e220903bc5dc8517df6ee358c31fdde78f435f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.789402) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.789879) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.790179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.815224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.815578) ========= 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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-11 16:57:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 156M=0s 2016-07-11 16:57:20 (156 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.960035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:20.960384) ========= 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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.030948 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:21.012260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 16:57:21.012631) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 75e220903bc5dc8517df6ee358c31fdde78f435f --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 75e220903bc5dc8517df6ee358c31fdde78f435f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-11 16:57:21,088 truncating revision to first 12 chars 2016-07-11 16:57:21,089 Setting DEBUG logging. 2016-07-11 16:57:21,089 attempt 1/10 2016-07-11 16:57:21,089 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/75e220903bc5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 16:57:22,733 unpacking tar archive at: autoland-75e220903bc5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.917225 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 16:57:22.951986) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:22.952324) ========= script_repo_revision: 75e220903bc5dc8517df6ee358c31fdde78f435f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:22.952739) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:22.953005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 16:57:22.971494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-11 16:57:22.971770) ========= /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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:57:23 INFO - MultiFileLogger online at 20160711 16:57:23 in /builds/slave/test 16:57:23 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 16:57:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:57:23 INFO - {'append_to_log': False, 16:57:23 INFO - 'base_work_dir': '/builds/slave/test', 16:57:23 INFO - 'blob_upload_branch': 'Autoland', 16:57:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:57:23 INFO - 'branch': 'Autoland', 16:57:23 INFO - 'buildbot_json_path': 'buildprops.json', 16:57:23 INFO - 'config_files': ('talos/mac_config.py',), 16:57:23 INFO - 'default_actions': ('clobber', 16:57:23 INFO - 'read-buildbot-config', 16:57:23 INFO - 'download-and-extract', 16:57:23 INFO - 'populate-webroot', 16:57:23 INFO - 'create-virtualenv', 16:57:23 INFO - 'install', 16:57:23 INFO - 'run-tests'), 16:57:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:57:23 INFO - 'download_minidump_stackwalk': True, 16:57:23 INFO - 'download_symbols': 'ondemand', 16:57:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:57:23 INFO - 'tooltool.py': '/tools/tooltool.py', 16:57:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:57:23 INFO - '/tools/misc-python/virtualenv.py')}, 16:57:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:57:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:57:23 INFO - 'installer_path': 'installer.exe', 16:57:23 INFO - 'log_level': 'info', 16:57:23 INFO - 'log_name': 'talos', 16:57:23 INFO - 'log_to_console': True, 16:57:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:57:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:57:23 INFO - 'opt_config_files': (), 16:57:23 INFO - 'pip_index': False, 16:57:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:57:23 INFO - 'cmd': ('bash', 16:57:23 INFO - '-c', 16:57:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:57:23 INFO - 'enabled': True, 16:57:23 INFO - 'halt_on_failure': False, 16:57:23 INFO - 'name': 'check_screen_resolution'},), 16:57:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:57:23 INFO - 'cmd': ('bash', 16:57:23 INFO - '-c', 16:57:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:57:23 INFO - 'enabled': True, 16:57:23 INFO - 'halt_on_failure': False, 16:57:23 INFO - 'name': 'check_screen_resolution'},), 16:57:23 INFO - 'run_cmd_checks_enabled': True, 16:57:23 INFO - 'sps_profile': False, 16:57:23 INFO - 'sps_profile_interval': 0, 16:57:23 INFO - 'suite': 'dromaeojs-e10s', 16:57:23 INFO - 'system_bits': '32', 16:57:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:57:23 INFO - 'title': 't-yosemite-r7-0099', 16:57:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:57:23 INFO - 'use_talos_json': True, 16:57:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:57:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:57:23 INFO - 'work_dir': 'build'} 16:57:23 INFO - ##### 16:57:23 INFO - ##### Running clobber step. 16:57:23 INFO - ##### 16:57:23 INFO - Running pre-action listener: _resource_record_pre_action 16:57:23 INFO - Running main action method: clobber 16:57:23 INFO - rmtree: /builds/slave/test/build 16:57:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:57:25 INFO - Running post-action listener: _resource_record_post_action 16:57:25 INFO - ##### 16:57:25 INFO - ##### Finished clobber step (success) 16:57:25 INFO - ##### 16:57:25 INFO - ##### 16:57:25 INFO - ##### Running read-buildbot-config step. 16:57:25 INFO - ##### 16:57:25 INFO - Running pre-action listener: _resource_record_pre_action 16:57:25 INFO - Running main action method: read_buildbot_config 16:57:25 INFO - Using buildbot properties: 16:57:25 INFO - { 16:57:25 INFO - "project": "", 16:57:25 INFO - "product": "firefox", 16:57:25 INFO - "script_repo_revision": "production", 16:57:25 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:57:25 INFO - "repository": "", 16:57:25 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:57:25 INFO - "buildid": "20160711145925", 16:57:25 INFO - "pgo_build": "False", 16:57:25 INFO - "basedir": "/builds/slave/test", 16:57:25 INFO - "buildnumber": 22, 16:57:25 INFO - "slavename": "t-yosemite-r7-0099", 16:57:25 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:57:25 INFO - "platform": "yosemite_r7", 16:57:25 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:57:25 INFO - "branch": "autoland", 16:57:25 INFO - "repo_path": "integration/autoland", 16:57:25 INFO - "revision": "75e220903bc5dc8517df6ee358c31fdde78f435f", 16:57:25 INFO - "stage_platform": "macosx64", 16:57:25 INFO - "builduid": "98ddb434f26246dc9baef6c53f31d313", 16:57:25 INFO - "slavebuilddir": "test" 16:57:25 INFO - } 16:57:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:57:25 INFO - Running post-action listener: _resource_record_post_action 16:57:25 INFO - ##### 16:57:25 INFO - ##### Finished read-buildbot-config step (success) 16:57:25 INFO - ##### 16:57:25 INFO - ##### 16:57:25 INFO - ##### Running download-and-extract step. 16:57:25 INFO - ##### 16:57:25 INFO - Running pre-action listener: _resource_record_pre_action 16:57:25 INFO - Running main action method: download_and_extract 16:57:25 INFO - mkdir: /builds/slave/test/build/tests 16:57: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')]} 16:57:25 INFO - https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:57:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:57:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:57:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:26 INFO - Downloaded 1199 bytes. 16:57:26 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:57:26 INFO - Using the following test package requirements: 16:57:26 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:57:26 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:57:26 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:57:26 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'jsshell-mac.zip'], 16:57:26 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:57:26 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:57:26 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:57:26 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:57:26 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:57:26 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:57:26 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:57:26 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:26 INFO - https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:27 INFO - Downloaded 18772202 bytes. 16:57:27 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'] 16:57:27 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 16:57:31 INFO - Return code: 0 16:57:31 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 16:57:31 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')]} 16:57:31 INFO - https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:32 INFO - Downloaded 18772202 bytes. 16:57:32 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'] 16:57:32 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 16:57:36 INFO - Return code: 0 16:57:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:36 INFO - https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:57:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:57:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:57:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:37 INFO - Downloaded 14403333 bytes. 16:57:37 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'] 16:57:37 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 16:57:37 INFO - Return code: 0 16:57: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')]} 16:57:37 INFO - https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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 16:57:40 INFO - Downloaded 112467286 bytes. 16:57:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:57:40 INFO - mkdir: /builds/slave/test/properties 16:57:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:57:40 INFO - Writing to file /builds/slave/test/properties/build_url 16:57:40 INFO - Contents: 16:57:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:57:41 INFO - Running post-action listener: _resource_record_post_action 16:57:41 INFO - Running post-action listener: set_extra_try_arguments 16:57:41 INFO - ##### 16:57:41 INFO - ##### Finished download-and-extract step (success) 16:57:41 INFO - ##### 16:57:41 INFO - ##### 16:57:41 INFO - ##### Running populate-webroot step. 16:57:41 INFO - ##### 16:57:41 INFO - Running pre-action listener: _resource_record_pre_action 16:57:41 INFO - Running main action method: populate_webroot 16:57:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:41 INFO - '--tppagecycles', 16:57:41 INFO - '7'], 16:57:41 INFO - 'tests': ['tsvgm']}}, 16:57:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:57:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:57:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['damp', 'tps']}, 16:57:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'tests': ['damp', 'tps']}, 16:57:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['dromaeo_dom']}, 16:57:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:57:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['basic_compositor_video']}, 16:57:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:57:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['a11yr', 16:57:41 INFO - 'ts_paint', 16:57:41 INFO - 'tpaint', 16:57:41 INFO - 'sessionrestore', 16:57:41 INFO - 'sessionrestore_no_auto_restore', 16:57:41 INFO - 'tabpaint']}, 16:57:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:57:41 INFO - 'ts_paint', 16:57:41 INFO - 'tpaint', 16:57:41 INFO - 'sessionrestore', 16:57:41 INFO - 'sessionrestore_no_auto_restore', 16:57:41 INFO - 'tabpaint']}, 16:57:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:57:41 INFO - 'ts_paint', 16:57:41 INFO - 'tpaint', 16:57:41 INFO - 'sessionrestore', 16:57:41 INFO - 'sessionrestore_no_auto_restore', 16:57:41 INFO - 'tabpaint']}, 16:57:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:57:41 INFO - 'ts_paint', 16:57:41 INFO - 'tpaint', 16:57:41 INFO - 'sessionrestore', 16:57:41 INFO - 'sessionrestore_no_auto_restore', 16:57:41 INFO - 'tabpaint']}, 16:57:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['a11yr', 16:57:41 INFO - 'ts_paint', 16:57:41 INFO - 'tpaint', 16:57:41 INFO - 'sessionrestore', 16:57:41 INFO - 'sessionrestore_no_auto_restore', 16:57:41 INFO - 'tabpaint']}, 16:57:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['a11yr', 16:57:41 INFO - 'ts_paint', 16:57:41 INFO - 'tpaint', 16:57:41 INFO - 'sessionrestore', 16:57:41 INFO - 'sessionrestore_no_auto_restore', 16:57:41 INFO - 'tabpaint']}, 16:57:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['tsvgx', 16:57:41 INFO - 'tsvgr_opacity', 16:57:41 INFO - 'tart', 16:57:41 INFO - 'tscrollx', 16:57:41 INFO - 'cart']}, 16:57:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:57:41 INFO - 'tsvgr_opacity', 16:57:41 INFO - 'tart', 16:57:41 INFO - 'tscrollx', 16:57:41 INFO - 'cart']}, 16:57:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'talos_options': ['--disable-e10s'], 16:57:41 INFO - 'tests': ['tp5o']}, 16:57:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'tests': ['tp5o']}, 16:57:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'talos_options': ['--disable-e10s', 16:57:41 INFO - '--xperf_path', 16:57:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:41 INFO - 'tests': ['tp5n']}, 16:57:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:41 INFO - 'talos_options': ['--xperf_path', 16:57:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:41 INFO - 'tests': ['tp5n']}}, 16:57:41 INFO - 'talos.zip': {'path': '', 16:57:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:41 INFO - Running post-action listener: _resource_record_post_action 16:57:41 INFO - ##### 16:57:41 INFO - ##### Finished populate-webroot step (success) 16:57:41 INFO - ##### 16:57:41 INFO - ##### 16:57:41 INFO - ##### Running create-virtualenv step. 16:57:41 INFO - ##### 16:57:41 INFO - Running pre-action listener: _resource_record_pre_action 16:57:41 INFO - Running main action method: create_virtualenv 16:57:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57: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 16:57:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:41 INFO - Using real prefix '/tools/python27' 16:57:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:45 INFO - Installing pip.................done. 16:57:45 INFO - Return code: 0 16:57:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:57: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 16:57: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 16:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:45 INFO - 'HOME': '/Users/cltbld', 16:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:45 INFO - 'LOGNAME': 'cltbld', 16:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:45 INFO - 'MOZ_NO_REMOTE': '1', 16:57:45 INFO - 'NO_EM_RESTART': '1', 16:57:45 INFO - 'PAGER': '/bin/cat', 16:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:45 INFO - 'PWD': '/builds/slave/test', 16:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:45 INFO - 'SHELL': '/bin/bash', 16:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:57:45 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:45 INFO - 'USER': 'cltbld', 16:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:45 INFO - 'XPC_FLAGS': '0x0', 16:57:45 INFO - 'XPC_SERVICE_NAME': '0', 16:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57: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 16:57:45 INFO - Cleaning up... 16:57:45 INFO - Return code: 0 16:57:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:57: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 16:57: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 16:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:45 INFO - 'HOME': '/Users/cltbld', 16:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:45 INFO - 'LOGNAME': 'cltbld', 16:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:45 INFO - 'MOZ_NO_REMOTE': '1', 16:57:45 INFO - 'NO_EM_RESTART': '1', 16:57:45 INFO - 'PAGER': '/bin/cat', 16:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:45 INFO - 'PWD': '/builds/slave/test', 16:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:45 INFO - 'SHELL': '/bin/bash', 16:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:57:45 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:45 INFO - 'USER': 'cltbld', 16:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:45 INFO - 'XPC_FLAGS': '0x0', 16:57:45 INFO - 'XPC_SERVICE_NAME': '0', 16:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:46 INFO - Downloading/unpacking psutil>=3.1.1 16:57:46 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 16:57:46 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 16:57:46 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 16:57:46 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 16:57:46 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 16:57:46 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 16:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:48 INFO - Installing collected packages: psutil 16:57:48 INFO - Running setup.py install for psutil 16:57:49 INFO - building 'psutil._psutil_osx' extension 16:57: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_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:57: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 16:57: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 16:57: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 16:57:49 INFO - building 'psutil._psutil_posix' extension 16:57: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 16:57:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:57:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:57:49 INFO - ^ 16:57:49 INFO - 1 warning generated. 16:57: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 16:57:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:50 INFO - Successfully installed psutil 16:57:50 INFO - Cleaning up... 16:57:50 INFO - Return code: 0 16:57:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:57: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 16:57: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 16:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:50 INFO - 'HOME': '/Users/cltbld', 16:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:50 INFO - 'LOGNAME': 'cltbld', 16:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:50 INFO - 'MOZ_NO_REMOTE': '1', 16:57:50 INFO - 'NO_EM_RESTART': '1', 16:57:50 INFO - 'PAGER': '/bin/cat', 16:57:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:50 INFO - 'PWD': '/builds/slave/test', 16:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:50 INFO - 'SHELL': '/bin/bash', 16:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:57:50 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:50 INFO - 'USER': 'cltbld', 16:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:50 INFO - 'XPC_FLAGS': '0x0', 16:57:50 INFO - 'XPC_SERVICE_NAME': '0', 16:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:57:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:57:53 INFO - Installing collected packages: mozsystemmonitor 16:57:53 INFO - Running setup.py install for mozsystemmonitor 16:57:53 INFO - Successfully installed mozsystemmonitor 16:57:53 INFO - Cleaning up... 16:57:53 INFO - Return code: 0 16:57:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:57: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 16:57: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 16:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:53 INFO - 'HOME': '/Users/cltbld', 16:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:53 INFO - 'LOGNAME': 'cltbld', 16:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:53 INFO - 'MOZ_NO_REMOTE': '1', 16:57:53 INFO - 'NO_EM_RESTART': '1', 16:57:53 INFO - 'PAGER': '/bin/cat', 16:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:53 INFO - 'PWD': '/builds/slave/test', 16:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:53 INFO - 'SHELL': '/bin/bash', 16:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:57:53 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:53 INFO - 'USER': 'cltbld', 16:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:53 INFO - 'XPC_FLAGS': '0x0', 16:57:53 INFO - 'XPC_SERVICE_NAME': '0', 16:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:53 INFO - Downloading/unpacking jsonschema==2.5.1 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:56 INFO - warning: no files found matching '*.txt' 16:57:56 INFO - no previously-included directories found matching 'build' 16:57:56 INFO - no previously-included directories found matching 'dist' 16:57:56 INFO - no previously-included directories found matching '.git*' 16:57:56 INFO - Installing collected packages: jsonschema, functools32 16:57:56 INFO - Running setup.py install for functools32 16:57:56 INFO - warning: no files found matching '*.txt' 16:57:56 INFO - no previously-included directories found matching 'build' 16:57:56 INFO - no previously-included directories found matching 'dist' 16:57:56 INFO - no previously-included directories found matching '.git*' 16:57:56 INFO - Successfully installed jsonschema functools32 16:57:56 INFO - Cleaning up... 16:57:56 INFO - Return code: 0 16:57:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:57: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 16:57: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 16:57:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:57:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:56 INFO - 'HOME': '/Users/cltbld', 16:57:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:56 INFO - 'LOGNAME': 'cltbld', 16:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:56 INFO - 'MOZ_NO_REMOTE': '1', 16:57:56 INFO - 'NO_EM_RESTART': '1', 16:57:56 INFO - 'PAGER': '/bin/cat', 16:57:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:56 INFO - 'PWD': '/builds/slave/test', 16:57:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:56 INFO - 'SHELL': '/bin/bash', 16:57:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:57:56 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:57:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:56 INFO - 'USER': 'cltbld', 16:57:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:56 INFO - 'XPC_FLAGS': '0x0', 16:57:56 INFO - 'XPC_SERVICE_NAME': '0', 16:57:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:56 INFO - Downloading/unpacking blobuploader==1.2.4 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:59 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57: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 16:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:58:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:00 INFO - Downloading docopt-0.6.1.tar.gz 16:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:58:00 INFO - Installing collected packages: blobuploader, requests, docopt 16:58:00 INFO - Running setup.py install for blobuploader 16:58:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:58:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:58:00 INFO - Running setup.py install for requests 16:58:01 INFO - Running setup.py install for docopt 16:58:01 INFO - Successfully installed blobuploader requests docopt 16:58:01 INFO - Cleaning up... 16:58:01 INFO - Return code: 0 16:58:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:58: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 16:58: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 16:58:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:58:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:01 INFO - 'HOME': '/Users/cltbld', 16:58:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:01 INFO - 'LOGNAME': 'cltbld', 16:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:01 INFO - 'MOZ_NO_REMOTE': '1', 16:58:01 INFO - 'NO_EM_RESTART': '1', 16:58:01 INFO - 'PAGER': '/bin/cat', 16:58:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:01 INFO - 'PWD': '/builds/slave/test', 16:58:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:01 INFO - 'SHELL': '/bin/bash', 16:58:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:58:01 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:58:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:01 INFO - 'USER': 'cltbld', 16:58:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:01 INFO - 'XPC_FLAGS': '0x0', 16:58:01 INFO - 'XPC_SERVICE_NAME': '0', 16:58:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-uXoquL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-tXbLCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:01 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-rwqAI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Ds_BAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-L0jnGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-P2iU_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-dazLAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-OOyfO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-igZROh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-arwTUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-oqg0EU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:02 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-U2twLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:03 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-6xY34c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:03 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-oMfi3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:03 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-dmUWtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:03 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-6C_ZFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:03 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-LraVk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:58:03 INFO - Running setup.py install for manifestparser 16:58:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:58:03 INFO - Running setup.py install for mozcrash 16:58:03 INFO - Running setup.py install for mozdebug 16:58:03 INFO - Running setup.py install for mozdevice 16:58:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozfile 16:58:04 INFO - Running setup.py install for mozhttpd 16:58:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozinfo 16:58:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozInstall 16:58:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:58:04 INFO - Running setup.py install for mozleak 16:58:04 INFO - Running setup.py install for mozlog 16:58:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:58:05 INFO - Running setup.py install for moznetwork 16:58:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:58:05 INFO - Running setup.py install for mozprocess 16:58:05 INFO - Running setup.py install for mozprofile 16:58:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:58:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:58:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:58:05 INFO - Running setup.py install for mozrunner 16:58:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:58:05 INFO - Running setup.py install for mozscreenshot 16:58:05 INFO - Running setup.py install for moztest 16:58:05 INFO - Running setup.py install for mozversion 16:58:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:58:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:58:06 INFO - Cleaning up... 16:58:06 INFO - Return code: 0 16:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:58: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 16:58: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 16:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:06 INFO - 'HOME': '/Users/cltbld', 16:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:06 INFO - 'LOGNAME': 'cltbld', 16:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:06 INFO - 'MOZ_NO_REMOTE': '1', 16:58:06 INFO - 'NO_EM_RESTART': '1', 16:58:06 INFO - 'PAGER': '/bin/cat', 16:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:06 INFO - 'PWD': '/builds/slave/test', 16:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:06 INFO - 'SHELL': '/bin/bash', 16:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:58:06 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:06 INFO - 'USER': 'cltbld', 16:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:06 INFO - 'XPC_FLAGS': '0x0', 16:58:06 INFO - 'XPC_SERVICE_NAME': '0', 16:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:58:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-LOijbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:58: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)) 16:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:58:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-775oLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:58: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)) 16:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:58:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-kW3slq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:58: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)) 16:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:58:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-uxnyHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:58: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)) 16:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:58:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-qubt4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:58: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)) 16:58:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:58:06 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-GoNqcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-oBjCXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-6wlzSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-0CyfpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-FNnu5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-Pqdlmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ZaknNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-rnn_rh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ls3Jio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:58: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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:07 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-VWYIgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:58:07 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)) 16:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:58:08 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-KeZzzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:58: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)) 16:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:58:08 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-fc5nw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58: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 16:58:10 INFO - Downloading blessings-1.6.tar.gz 16:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:58:10 INFO - Installing collected packages: blessings 16:58:10 INFO - Running setup.py install for blessings 16:58:10 INFO - Successfully installed blessings 16:58:10 INFO - Cleaning up... 16:58:10 INFO - Return code: 0 16:58:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:11 INFO - Reading from file tmpfile_stdout 16:58:11 INFO - Current package versions: 16:58:11 INFO - blessings == 1.6 16:58:11 INFO - blobuploader == 1.2.4 16:58:11 INFO - docopt == 0.6.1 16:58:11 INFO - functools32 == 3.2.3-2 16:58:11 INFO - jsonschema == 2.5.1 16:58:11 INFO - manifestparser == 1.1 16:58:11 INFO - mozInstall == 1.12 16:58:11 INFO - mozcrash == 0.17 16:58:11 INFO - mozdebug == 0.1 16:58:11 INFO - mozdevice == 0.48 16:58:11 INFO - mozfile == 1.2 16:58:11 INFO - mozhttpd == 0.7 16:58:11 INFO - mozinfo == 0.9 16:58:11 INFO - mozleak == 0.1 16:58:11 INFO - mozlog == 3.2 16:58:11 INFO - moznetwork == 0.27 16:58:11 INFO - mozprocess == 0.23 16:58:11 INFO - mozprofile == 0.28 16:58:11 INFO - mozrunner == 6.12 16:58:11 INFO - mozscreenshot == 0.1 16:58:11 INFO - mozsystemmonitor == 0.3 16:58:11 INFO - moztest == 0.7 16:58:11 INFO - mozversion == 1.4 16:58:11 INFO - psutil == 3.1.1 16:58:11 INFO - requests == 1.2.3 16:58:11 INFO - wsgiref == 0.1.2 16:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:58: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 16:58: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 16:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:11 INFO - 'HOME': '/Users/cltbld', 16:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:11 INFO - 'LOGNAME': 'cltbld', 16:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:11 INFO - 'MOZ_NO_REMOTE': '1', 16:58:11 INFO - 'NO_EM_RESTART': '1', 16:58:11 INFO - 'PAGER': '/bin/cat', 16:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:11 INFO - 'PWD': '/builds/slave/test', 16:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:11 INFO - 'SHELL': '/bin/bash', 16:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:58:11 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:11 INFO - 'USER': 'cltbld', 16:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:11 INFO - 'XPC_FLAGS': '0x0', 16:58:11 INFO - 'XPC_SERVICE_NAME': '0', 16:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58: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)) 16:58:11 INFO - Cleaning up... 16:58:11 INFO - Return code: 0 16:58:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:58: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')]} 16:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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')]} 16:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:58: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 0x10568aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10571f618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fecf047aff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, '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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 16:58: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 16:58: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 16:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:11 INFO - 'HOME': '/Users/cltbld', 16:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:11 INFO - 'LOGNAME': 'cltbld', 16:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:11 INFO - 'MOZ_NO_REMOTE': '1', 16:58:11 INFO - 'NO_EM_RESTART': '1', 16:58:11 INFO - 'PAGER': '/bin/cat', 16:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:11 INFO - 'PWD': '/builds/slave/test', 16:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:11 INFO - 'SHELL': '/bin/bash', 16:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:58:11 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:11 INFO - 'USER': 'cltbld', 16:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:11 INFO - 'XPC_FLAGS': '0x0', 16:58:11 INFO - 'XPC_SERVICE_NAME': '0', 16:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:58:11 INFO - Cleaning up... 16:58:11 INFO - Return code: 0 16:58:11 INFO - Running post-action listener: _resource_record_post_action 16:58:11 INFO - Running post-action listener: _start_resource_monitoring 16:58:11 INFO - Starting resource monitoring. 16:58:11 INFO - ##### 16:58:11 INFO - ##### Finished create-virtualenv step (success) 16:58:11 INFO - ##### 16:58:11 INFO - ##### 16:58:11 INFO - ##### Running install step. 16:58:11 INFO - ##### 16:58:11 INFO - Running pre-action listener: _resource_record_pre_action 16:58:11 INFO - Running main action method: install 16:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:58:12 INFO - Reading from file tmpfile_stdout 16:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:58:12 INFO - Reading from file tmpfile_stdout 16:58:12 INFO - Output received: 16:58:12 INFO - Usage: mozinstall [options] installer 16:58:12 INFO - Options: 16:58:12 INFO - -h, --help show this help message and exit 16:58:12 INFO - -d DEST, --destination=DEST 16:58:12 INFO - Directory to install application into. [default: 16:58:12 INFO - "/builds/slave/test"] 16:58:12 INFO - --app=APP Application being installed. [default: firefox] 16:58:12 INFO - mkdir: /builds/slave/test/build/application 16:58: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'] 16:58: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 16:58:46 INFO - Reading from file tmpfile_stdout 16:58:46 INFO - Output received: 16:58:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:58:46 INFO - Running post-action listener: _resource_record_post_action 16:58:46 INFO - ##### 16:58:46 INFO - ##### Finished install step (success) 16:58:46 INFO - ##### 16:58:46 INFO - ##### 16:58:46 INFO - ##### Running run-tests step. 16:58:46 INFO - ##### 16:58:46 INFO - Running pre-action listener: _resource_record_pre_action 16:58:46 INFO - Running main action method: run_tests 16:58:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:46 INFO - 2016-07-11 16:58:46.619 screenresolution[1641:7500] starting screenresolution argv=screenresolution get 16:58:46 INFO - 2016-07-11 16:58:46.622 screenresolution[1641:7500] Display 0: 1600x1200x32@60 16:58:46 INFO - 2016-07-11 16:58:46.627 screenresolution[1642:7502] starting screenresolution argv=screenresolution list 16:58:46 INFO - Available Modes on Display 0 16:58:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:46 INFO - Intel Iris: 16:58:46 INFO - Chipset Model: Intel Iris 16:58:46 INFO - Type: GPU 16:58:46 INFO - Bus: Built-In 16:58:46 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:46 INFO - Vendor: Intel (0x8086) 16:58:46 INFO - Device ID: 0x0a2e 16:58:46 INFO - Revision ID: 0x0009 16:58:46 INFO - Displays: 16:58:46 INFO - Display: 16:58:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:46 INFO - Display Serial Number: 1600x1200 60 16:58:46 INFO - Main Display: Yes 16:58:46 INFO - Mirror: Off 16:58:46 INFO - Online: Yes 16:58:46 INFO - Rotation: Supported 16:58:46 INFO - Return code: 0 16:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:46 INFO - Python 2.7.3 16:58:46 INFO - Return code: 0 16:58:46 INFO - grabbing minidump binary from tooltool 16:58: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')]} 16:58: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 0x1055eed30>, '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 0x105353db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1055e6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58: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 16:58: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 16:58: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 16:58:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:46 INFO - Return code: 0 16:58:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:58:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:58:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58: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/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 16:58: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/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 16:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.5lP0qmqTYQ/Render', 16:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:46 INFO - 'HOME': '/Users/cltbld', 16:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:46 INFO - 'LOGNAME': 'cltbld', 16:58:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:46 INFO - 'MOZ_NO_REMOTE': '1', 16:58:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:46 INFO - 'NO_EM_RESTART': '1', 16:58:46 INFO - 'PAGER': '/bin/cat', 16:58:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:46 INFO - 'PWD': '/builds/slave/test', 16:58:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:46 INFO - 'SHELL': '/bin/bash', 16:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PbhUAA3gIy/Listeners', 16:58:46 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 16:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:46 INFO - 'USER': 'cltbld', 16:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:46 INFO - 'XPC_FLAGS': '0x0', 16:58:46 INFO - 'XPC_SERVICE_NAME': '0', 16:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58: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/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 16:58:47 INFO - mozversion application_buildid: 20160711145925 16:58:47 INFO - mozversion application_changeset: 75e220903bc5dc8517df6ee358c31fdde78f435f 16:58:47 INFO - mozversion application_display_name: Nightly 16:58:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:47 INFO - mozversion application_name: Firefox 16:58:47 INFO - mozversion application_remotingname: firefox 16:58:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:58:47 INFO - mozversion application_vendor: Mozilla 16:58:47 INFO - mozversion application_version: 50.0a1 16:58:47 INFO - mozversion platform_buildid: 20160711145925 16:58:47 INFO - mozversion platform_changeset: 75e220903bc5dc8517df6ee358c31fdde78f435f 16:58:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:58:47 INFO - mozversion platform_version: 50.0a1 16:58:47 INFO - using testdate: 1468281527 16:58:47 INFO - actual date: 1468281527 16:58:47 INFO - starting webserver on 'localhost:49273' 16:58:47 INFO - SUITE-START | Running 2 tests 16:58:47 INFO - TEST-START | dromaeo_css 16:58:47 INFO - operating with platform_type : mac_ 16:58:47 INFO - Initialising browser for dromaeo_css test... 16:58:47 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpyvWs3D/profile http://localhost:49273/getInfo.html) 16:58:50 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 16:58:50 INFO - PROCESS | 1652 | colorDepth:24 16:58:50 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 16:58:50 INFO - PROCESS | 1652 | __metrics 16:58:50 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 16:58:51 INFO - TEST-INFO | 1652: exit 0 16:58:51 INFO - Browser initialized. 16:58:51 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:51 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpyvWs3D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:59:03 INFO - PROCESS | 1655 | RSS: Main: 254173184 16:59:03 INFO - PROCESS | 1655 | 16:59:52 INFO - PROCESS | 1655 | 1468281592868 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] 17:02:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 17:02:06 INFO - PROCESS | 1655 | RSS: Main: 266649600 17:02:06 INFO - PROCESS | 1655 | 17:05:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:05:08 INFO - PROCESS | 1655 | RSS: Main: 275447808 17:05:08 INFO - PROCESS | 1655 | 17:08:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:08:11 INFO - PROCESS | 1655 | RSS: Main: 280096768 17:08:11 INFO - PROCESS | 1655 | 17:11:13 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:11:13 INFO - PROCESS | 1655 | RSS: Main: 278999040 17:11:13 INFO - PROCESS | 1655 | 17:14:16 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 17:14:17 INFO - PROCESS | 1655 | RSS: Main: 282853376 17:14:17 INFO - PROCESS | 1655 | 17:17:19 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 17:17:20 INFO - PROCESS | 1655 | RSS: Main: 283066368 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | __start_tp_report 17:17:20 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 17:17:20 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 17:17:20 INFO - PROCESS | 1655 | |i|pagename|runs| 17:17:20 INFO - PROCESS | 1655 | |0;dojo.html;3423.5720534933134;3445.2937147884686;3466.8093254870987;3471.722262219023;3488.4418493041103;5124;5461.49808802579;5851.327097383797;5945.732442040107;6014.789482368118;5775.451332123452;5937.2578427696535;5958.821235362946;6002.8499287517725;6111.083337499377;4332.306830907056;5308.283381743454;5326.201069839516;5372.54333381663;5398.514133727964;5285.365756109272;5410.621256512046;5451.073317536028;5498.697571633558;5505.064139096363;5164.328637277167;5361.276227709248;5373.274607927919;5393.703346315951;5410.783568657249;5201;5260.92108618371;5261.158214685632;5295.073362161645;5298.36419629643;4545.795439205243;5186.948130518722;5236.7905283788605;5274.841754747364;5305.893882122375;5736.827895163152;5788.942110578882;5852;5907;5960.254968128984;6240.095186198021;6288.182536270256;6297;6315.810525684236;6321.778737744203;6347.523935704794;6357.713902874381;6363.968180159116;6377.947638639619;6389.808305750835;5796.362400135981;5946.8810623787285;5957.195778569924;5998.130271110665;6009.819705408845;6430.710618022106;6489.837754056092;6491.51313651478;6498.837529061717;6509.414152726277;6219.533534984895;6273.153124328249;6283.434490895841;6286.214223222098;6295.622262664255;6165;6180.289266734293;6199.721012554446;6215.285242197115;6254.968725156436;6134.252905685562;6222.973209420486;6251.718672659741;6260.123582698426;6264.091706702503;5460;6071.5565643292075;6276.968615156895;6279.780207692709;6315.463185629273;4542.613877820356;4925.482824303468;4928.852134435972;4983.975080124576;4991.251312303184;4425.535318791481;4444.933326000112;4455.22033644111;4473.329000649928;4505.301678239878;5780.132980053026;5869.8239052828485;5876.236089308448;5876.676782776988;5904.586678932434;6230.190075290274;6241.313455519889;6334.1765570475545;6334.334894836068;6365.713542890581;5996.550258730613;5996.940030599638;6025.126356678345;6025.4577088061405;6040.044770550927;5424.918626220609;5493.615446918678;5557.41647127054;5558.166275058774;5607.607467477319;6415.518836087312;6541.182352205974;6542.672866356568;6549.6070235786;6563.212414510289;6332.841678957879;6334.081558173947;6350.555461117678;6367.554271200971;6370.904436433365;6151.784687535915;6442.516811239082;6457.515686323639;6536.869262614626;6650.933490665031;6255.31191568918;6284.057391391328;6292.402221788922;6303.716332765129;6329.461995730415;5277.894442111059;5307.681539107666;6325.367463253638;6355.87288254223;6367.458766004941;5545.306836645419;6100.187591190105;6122.733612273432;6139.877202455837;6206.379362063757;6176.598521096114;6224.439800417984;6246.750129994749;6261.530385221035;6271.62370257786;5278.630495865253;6099.451049405575;6110.388961103854;6188.504919606511;6198.2871969722255;4921.311016457627;5518.613697041169;6181.876362472815;6190.566660333913;6283.403076707888;5551.861203469945;5775.480206781242;6196.969015154896;6197.411245931629;6209.906851397142 17:17:20 INFO - PROCESS | 1655 | |1;ext.html;483.42713884047396;503.46381104124106;504.5207053299367;526.4893053737873;526.9288646032782;33014.50478242825;37315.62684373155;39419.60580394195;39595.40606890892;39663.206735865264;41396.79301603488;41846.79076604613;41853.9073046348;41973.74078777634;41978.58021419785;8676.609552570118;8760.299176065899;8808.867866982;8817.162369574913;8819.250363719091;9625.518724063804;9737.610495580167;9744;9759.609615615367;9765.609375624967;9705.854412183822;9740.853887191663;9754.219662426989;9786.853197202048;9805.460699661517;9661.855072173923;9663.323567350288;9702.466364349957;9714;9725.854112188323;9564.808703825884;9632.27757918152;9642.807143857153;9648.469334186617;9650.565724542343;39573;39731.20537589261;39799.60200397988;40064.59935400638;40292.19415611671;3552.6802587767224;3655.780653160819;3674.228412033476;3681.9815900920594;4144.91710165798;31061.378772424425;32912.67087329144;32971.340573188405;32995.83502082474;33001.6699833001;3231.2891163943896;3435.811030393327;3462.117160124177;3464.6188919219117;3467.271872906693;467233;471035;476206;476381;482854;68782.65608672025;69605.30394696089;69705.65147174231;69753;69804;69079.61840763157;70370.64814675893;71033.64483177655;71571.64214178895;72068.63965680244;16703;16739.33042678279;16970.236339364757;16979.405720799714;17037.57406064858;11739.354335511458;12017.798220177912;12020.97821685149;12962.80555791645;12967.935160324138;16247.431339903047;16419.58951026234;18249.726254106197;19924;20017.199312027646;8697.130286971253;8892.3330750194;8912.242459391024;8935.195832375117;8955.641774328953;841.5750046226616;941.6562954521687;976.7899901521065;1007.5516395204064;1052.074174726236;27094.5935810963;30678.38643227123;30857.919972801294;31262.531062034086;31444.52833207504;1034.5086084109987;1064.2869277584036;1155.8786327435666;1205.2045649871043;1219.4634760202032;15048.398064077533;15069.623259418602;15571.688566228839;15930.761038584431;16282.75575866363;701276;707470;714589;716278;718068;57905;59442;60088.098678519855;60165;60217.09674354888;1386.4939297156666;1391.2973948156116;1429.2139323372103;1452.3028946105928;1456.6285597172864;29068;29524.114276571738;31019.224519387197;31615;31989.6801031996;50876.491235087175;51349.48650513597;51354.48645513497;51355;51609.48390516197;568394;569612;570947;587934;588311;27177.45645087127;27298;27706.584401234402;27752.861235693694;27853.582196267478;46561.53438465572;46584.767076164404;47015.529844701116;47254.527454725016;47620.523794762994;32521.837390812896;39459.802700986314;39837.203255935296;40117.39823902585;40733.38899916563;39716.80141599273;40159.99600010023;40169.39745903872;40623;40757.79621101876;38016.61983380241;38154.0461488465;38688.6131138685;38696.80651596724;39042;31101.844490777403;31502.527462088547;34183.80356687504;34624.36813665659;34993;25519.36201594975;25655.358616034748;25786.226413207634;26006;26114.63386778803 17:17:20 INFO - PROCESS | 1655 | |2;jquery.html;369.4974834225454;385.17572395074546;394.2765026176965;396.81151453059783;410.3475473996347;19558.41324760256;19919.502012449695;21436.89281553594;22007.889960550216;22355;21125.68311475329;21277.893610531926;22123.668144977797;22184.445388865286;22291.888540557316;5668.631538949965;6163.2604087509335;6177.66022868742;6183.072539119124;6190.288116866551;4178.164367126572;6053.606515576474;6501.967490162542;6786.219584747743;6810.897836532431;5854.473097421232;6794.932050679504;6807.319268073178;6849.2465828758795;6849.931500685004;6115.510759139258;6174.8147555573405;6190.999999999977;6209.689515524251;6210.689465526728;5829.125631155318;6008.399160084;6050.485708714765;6076.118962750421;6093.482054025413;11110.777784444346;12596.307203103826;13390.196588204739;13546;13754.93122534391;2196.1544805249932;2246.820419279875;2273.624851899435;2575.742425757428;2726.4274502354333;10355.585776568929;10829.891701082966;12348.567800127043;15690.058596484247;16390.508284751475;1707.1464267866068;1798.2806877249204;1895.4124221491381;1921.8750781199178;1973.0923775063488;113402.43298783453;115261;116000;116981.41509292484;119680;11706.88293117058;11708.297502149899;11759.941200293944;11768.293902365886;11769.823452648217;14386.928065359607;14603.707925841423;14870.182139982406;14947.850521494645;15003.474878379204;8659.350548708746;8695.217430431292;8735.1701588349;8765.430247033923;8779.29765618749;8602.096779838152;8610.182032707007;8612.311015118776;8716.782080447912;8776.429532080394;4550.089982003613;4581.2440947243995;4653.115907977473;4669.766511674403;4694.624430045588;1785.5893144576821;1788.320438233463;1846.3537761783268;1914.5405102775233;1968.95645307987;929.8837645294203;933.9533023348805;994.5126887825058;997.8503224516236;1020.4489575629077;21499.2475263365;21543.461413464476;21716;21788;22069;834.4826207751233;929.4748467116193;954.8758661374115;962.3407965543626;990.5740531571349;11369.488373023234;11560.248583842023;11611.941940290413;11697.2981621103;11706.941465292619;503408;511559;512056;565092;574157;118377.40811295889;142699;150055;150458;151110.24444877924;890.3100097424548;977.4917043137671;1005.3113617172261;1018.3889666200369;1021.9693409197736;16762.58093547671;19933.900330498836;20215.59568808645;20230.79769202289;20272.18911243534;55744.442555575544;56389.71805140948;57417.71291143518;57631.84736305167;59572;86745.26509469649;87027;87199;87535.56232218798;88235.11764882525;8153.714619988509;8297.25324720778;8317.459365141247;8408.87386689188;8483.74548763538;12376.858319899668;12523.74952500963;13209.867901321248;13211.207327560378;13519;11507.827382589436;11636.41817909118;11714.70713232176;11754.70613234676;11768.646940591796;11279.774404512027;11346.546138154381;11614.88385116138;11634.825477617673;11635.709107272047;10121;10909.945450272699;11508;11860.229085109786;11934.104942129201;8297.377696672653;8345.95827020861;8401.99176098872;8413.747587572383;8482;8375.706850260212;11369;11547.769044618892;11620.941895290469;11763 17:17:20 INFO - PROCESS | 1655 | |3;mootools.html;1530.4796369234457;1565.4677409680705;1787.213626004558;1825.2698920431833;1903.876248043876;7902.920970790305;8284.585770711456;8394.244517993387;8867.467951922881;8975.551222438884;7241.67412466439;8517.659293628247;8638.09300023498;8664.523451210182;8711.520866352364;2316.837821352506;2341.075275266269;2343.3087239264373;2346.3312955807596;2347.58917189492;2239.9552008959813;2300.8274379421528;2319.095552734435;2324.8256380771427;2333.673285739998;2307.5038866643667;2309.3187509684685;2310.7342655594653;2335.252719129879;2341.3912382780513;2284.6230371988604;2289.8855057247238;2295.6097463431174;2307.6538519222167;2322.883855807203;1901.9809801901943;2256.796888280063;2263.6830843681896;2268.3081660093667;2269.0923630547913;8697.347698922544;8703.129687031309;8821.51481668508;8821.60302786376;8853.848999630007;5141.177411614161;5237.659552129099;5287.180487024518;5294.655847369909;5329.467053294678;3274.5579346788118;3336.4995250712345;3366.4613661814237;3391.915202119942;3543;1033.9017793309624;1055.4933631856675;1062.5484169228048;1068.3376306689902;1069.4813015687384;11483.712907177303;11600.94199528997;11616.419179041099;11621.825672614917;11650.47572859215;4562.270036794163;4614.538546145426;4758.405199350082;4771.212749896297;4781;8422;9672.56473458682;9821.312508124363;9822.508874556244;9857.063578959987;4535.705179163344;4723.811047558128;5313.388960269541;5324.547413469899;5329;3749.4938183345444;4137.731047481904;4339.7396156230725;4872.756362181876;4886.657933944661;3822.9426558601645;3883.922321553553;3909.3354129798004;3933.1936952925153;3955.1806169161932;1211.7758214730304;1260.3257257367266;1266.2402558464848;1274.6940734223906;1282.2114399644338;808.8058865872148;866.3112825303898;946.8059047895302;968.7965527239218;994.16986816008;6057.121717350959;6066.48434883031;6095.542834287447;6140.048292514667;6146.354632763496;428.1949934123827;439.7845055922575;442.2106539826394;442.98671039868856;980.5979548385128;4034.5158580969883;4043.3732771420478;4075.9388609170887;4101.138760860253;4124.938125928114;10395.532201050972;10593;10682.252242343116;10708.946455267675;10802.027817496462;9048.276137908952;9061.54692265384;10533;10596.470176491144;10668;6614.570052946543;8016.879746803803;8088.474249173785;8161.673533058611;8269.338452923632;5262.236975638588;5611.551075913999;5984.581079324405;6092.664903430176;6183.81448556544;9867.605295788375;9870.555824987749;9883.456409897524;9901.504924753877;10067;9891.406515609087;10015.948325426018;10043;10226.744331391776;10286.948565257126;6981.162260528769;7371.520851144658;7519.796832506772;7643.694252230071;7698.538087714755;8334.249917507212;8353.20644538768;8395.790105247417;8425.199606037417;8434.072252052147;7372.815679608053;7502.062242219723;7535.660895259617;7572.924270757222;7635.083789945242;7217.711291548279;7263.709451621876;7287.781366559012;7320.524165929198;7330.230325815925;7048.612326322102;7077.115360579927;7119.323664251888;7127.322904324081;7133.82165445868;4858.975705121452;4905.313256144214;5029.245613158056;5037.949620503895;5085.542301192911;5070.746462676925;5144.76848541824;5170.457102004236;5186.870328241824;5280.471952804689 17:17:20 INFO - PROCESS | 1655 | |4;prototype.html;261.64416393704556;306.1122744042277;310.6691373687023;320.79629435308584;323.3871812914526;4234.407182994383;4699.3683537219185;5534;5657.886842263158;5703.001974654435;5223.921641175376;5538.39695343188;5590.804321848736;5654.660720356771;5658.264425624663;3504.8072356020407;3766.5291838520184;3820.2932457495313;4002.0395105174694;4188.518320393148;3853.3064048471265;3945.329294020009;3979.5622481527007;4250.06498570314;4276.935845962297;3824.374640777672;4160.687948403866;4185.686073544481;4198.580141985807;4219.662427005832;3456.343294773985;3631.473436351714;3859.0545316397383;3863.613638636142;4186.91626167475;3299.5875515560556;3354.289312450643;3617.801020943847;3627.4921510988484;3629.818509074562;4758.643101767347;5126.078135462788;5479.150731636602;5483.232347471358;5498.505134537871;4820.951790482085;4840.9515904840855;4842.951570484321;4849.9757501212625;4853.320535125085;4929.112759703252;5209.1665333546825;5709.457601527848;5959.109831731606;5963.463288304073;2961.6446026476747;3971.5631280559114;3973.7615743055508;3977.548194908866;4023.879283621496;5842.503387212092;5949.8215053548465;6055.485283750886;6192.81421557354;6192.938070619326;3496;3998.9605301296547;4004.7797371144284;4009;4028.871915863563;3794.6395092466173;4061.5532291447917;4068.8372465101656;4079.449274347925;4098.508179018537;4479.552044795494;4509.302372054884;4685.625149988061;4758.500357462486;4764.094821983812;4571.634269258518;5004.099262132851;5405.918911216335;5674.148877668383;5820.796272130455;1164.976700465986;1171.6075114836626;1185.7924863149087;1378.2488543743684;1397.224540380099;677.7729460630645;705.8870580707062;715.7387553542919;861.2894362151251;861.8621020636668;3711.202091550276;4037.555868854424;4218.451601291812;4656.604188644003;4657.6506761992305;4249.745015299092;4256.723312984646;4998.600951353043;5170.37955445349;5298.788048478094;4007.4189242560246;4541.818327266872;4584.0806110775475;4659.58063774262;4672.789724462407;2369.5308908476854;2552.205335157999;2626.3565426470636;2714.4164004739077;2764.8064635475325;4618.983823558811;4966;5347.491988261187;5372.704501252469;5432.387462337501;4851.708897466164;4979.551840334388;5010.824621138243;5262.9474105179115;5299.3905700844125;4403.625691816167;4471.61991230749;4761.714297142183;5102.617303702237;5378.892422151535;4770.4275486940405;5134.405915858839;5161.683770638463;5172.793088276427;5191.312823332508;3924;4489.565482405897;4636.953630463652;4903.567502748162;5086.32151390033;4681;5013.824516141917;5245.6918955659385;5376;5397.815288979521;3152.6689697581423;3524.8766293179615;3539.7876127432437;3556.4309710446205;3576.2311103112957;4568.908621827612;5130.12787826078;5155.32980712505;5162.09663308912;5825.94174058254;4466.64266858657;5054.418741844588;5256.6320357574605;5944.3164036136395;5984.760609575743;5136.948630513796;5885.205497257815;5901.616394934315;5911.344823449441;5946.583739138392;5489.533389661923;5803.361630220588;5803.767849285981;5907.788903274733;5963.224780778644;5185.870353241048;5316.680999140064;5789.3658385435365;6062;6068.666223357758;4808.206645903387;5392.433794451683;5774.787294668166;5906.316699740553;5906.940930590639 17:17:20 INFO - PROCESS | 1655 | |5;yui.html;716.7491378017692;719.3310221494011;743.2790193512297;754.4040208235494;762.870312046952;13794;14909.179995100265;15690.45083422082;15714.135722535257;15740.921295393522;11094.778104437906;12095.274283542994;12257.816132758016;12555.748885022294;14698.191599462025;695.7112798188771;856.614523464442;878.5870640798814;886.4769785826361;890.2343984173606;837.3719710217337;875.6453636277317;885.8848349714528;889.7864512517014;893.0578239956843;941.0025373104497;941.7598512379334;941.9105185007447;943.4056544377067;950.6340059077236;913.1963871792813;934.5887809363858;935.9953200234023;936.2042264075516;936.5410948635154;650.7852408705116;681.3765404654735;683.9159931508565;695.5513693667556;698.2249702829855;15488.07071575709;15706.293216805272;15774.290156942965;15848.207589620588;15883.682326353524;13842.446302147902;14395.71208575833;14879.851201487954;14884.404623815035;14887.627809304853;10859.696836379684;11993.460294286779;12256.693582660415;12538.937305313506;12619.305938173396;3736.6823819975334;3810.295095407331;4026;4047.55476897544;4051.5948405159543;123946.76053239443;124812.37593811973;125786;126494;128317.35841320733;11334.610155699647;11481.770364592661;11565.537378504765;11578.189526733047;12071.75856482883;23937.281881543582;23944.640830387558;23964.64053039206;23971.640425393634;24016.63975040376;8202.548859812767;8236.464629799044;8252.546109964009;8327.583620819056;8439.957800211083;4520.95479045212;4614.1694494991225;4621.4223222097235;4663.766811659403;4783.043391321749;3575.106223444139;3697.574778900407;3703.870364537282;3707.1658876753054;3847.2690188864026;631.6557476175495;681.9693113809791;693.6358411833727;702.8137543550963;723.3959643697466;631.7630888416844;686.3959715450471;688.9862202755917;702.5328156775789;710.9217986021533;9563.234941204686;9592.376495527908;9713.854292185622;9722.659706910224;9998.900560714088;559.7247190171938;656.3403779201872;668.5320275806955;688.6935313785317;690.7858563845224;4558.8632341029825;4687.929681054787;4730.550597693214;4742.07529531738;4776.713397196179;93859;112855.43572282085;146533.8019929702;159851;164562;140291.29854350662;140349;140693;142683.28658356643;143085.28457357647;104090;120410.3979480097;121679;122288;123661.38169309276;8832.293416526534;9023.503707296162;9069.138431848964;9098.772530686521;9279.76800579991;57482.7125864368;61375;61884.690576546825;63050;63375.732485350956;71091.64454177696;85748;88831.7792055178;95480;98094;11892;11975.461104250504;12080.335581542748;12372.381380931098;12559.80268827314;13477.865221347662;13488.662783430493;13508.459661613426;13560.45758169662;13564.525241616891;11065.944670276596;12084.643325145309;12213.267203967791;12414.565490207799;12691.619251422102;10369.74075648115;12393.504259829506;12480.313582753035;12626.936865315614;12834.101612887009;12283.69290767738;12289.446974885972;12440.31578263168;13326.666833329244;14327.212003339917;10951.83572246401;11210;11264.063864288388;11349.262297950607;11525.423728813357;9493.05069493045;10063.89936100659;10069.295149339476;11772.234804737665;11849.703757405789 17:17:20 INFO - PROCESS | 1655 | __end_tp_report 17:17:20 INFO - PROCESS | 1655 | __start_cc_report 17:17:20 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,453 17:17:20 INFO - PROCESS | 1655 | __end_cc_report 17:17:20 INFO - PROCESS | 1655 | __startTimestamp1468282640099__endTimestamp 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | ------- Summary: start ------- 17:17:20 INFO - PROCESS | 1655 | Number of tests: 6 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5809.95 Median:6040.04 stddev:675.62 (11.2%) stddev-sans-first:651.24 17:17:20 INFO - PROCESS | 1655 | Values: 3423.6 3445.3 3466.8 3471.7 3488.4 5124.0 5461.5 5851.3 5945.7 6014.8 5775.5 5937.3 5958.8 6002.8 6111.1 4332.3 5308.3 5326.2 5372.5 5398.5 5285.4 5410.6 5451.1 5498.7 5505.1 5164.3 5361.3 5373.3 5393.7 5410.8 5201.0 5260.9 5261.2 5295.1 5298.4 4545.8 5186.9 5236.8 5274.8 5305.9 5736.8 5788.9 5852.0 5907.0 5960.3 6240.1 6288.2 6297.0 6315.8 6321.8 6347.5 6357.7 6364.0 6377.9 6389.8 5796.4 5946.9 5957.2 5998.1 6009.8 6430.7 6489.8 6491.5 6498.8 6509.4 6219.5 6273.2 6283.4 6286.2 6295.6 6165.0 6180.3 6199.7 6215.3 6255.0 6134.3 6223.0 6251.7 6260.1 6264.1 5460.0 6071.6 6277.0 6279.8 6315.5 4542.6 4925.5 4928.9 4984.0 4991.3 4425.5 4444.9 4455.2 4473.3 4505.3 5780.1 5869.8 5876.2 5876.7 5904.6 6230.2 6241.3 6334.2 6334.3 6365.7 5996.6 5996.9 6025.1 6025.5 6040.0 5424.9 5493.6 5557.4 5558.2 5607.6 6415.5 6541.2 6542.7 6549.6 6563.2 6332.8 6334.1 6350.6 6367.6 6370.9 6151.8 6442.5 6457.5 6536.9 6650.9 6255.3 6284.1 6292.4 6303.7 6329.5 5277.9 5307.7 6325.4 6355.9 6367.5 5545.3 6100.2 6122.7 6139.9 6206.4 6176.6 6224.4 6246.8 6261.5 6271.6 5278.6 6099.5 6110.4 6188.5 6198.3 4921.3 5518.6 6181.9 6190.6 6283.4 5551.9 5775.5 6197.0 6197.4 6209.9 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:72477.14 Median:40164.70 stddev:159462.76 (397.0%) stddev-sans-first:159818.48 17:17:20 INFO - PROCESS | 1655 | Values: 483.4 503.5 504.5 526.5 526.9 33014.5 37315.6 39419.6 39595.4 39663.2 41396.8 41846.8 41853.9 41973.7 41978.6 8676.6 8760.3 8808.9 8817.2 8819.3 9625.5 9737.6 9744.0 9759.6 9765.6 9705.9 9740.9 9754.2 9786.9 9805.5 9661.9 9663.3 9702.5 9714.0 9725.9 9564.8 9632.3 9642.8 9648.5 9650.6 39573.0 39731.2 39799.6 40064.6 40292.2 3552.7 3655.8 3674.2 3682.0 4144.9 31061.4 32912.7 32971.3 32995.8 33001.7 3231.3 3435.8 3462.1 3464.6 3467.3 467233.0 471035.0 476206.0 476381.0 482854.0 68782.7 69605.3 69705.7 69753.0 69804.0 69079.6 70370.6 71033.6 71571.6 72068.6 16703.0 16739.3 16970.2 16979.4 17037.6 11739.4 12017.8 12021.0 12962.8 12967.9 16247.4 16419.6 18249.7 19924.0 20017.2 8697.1 8892.3 8912.2 8935.2 8955.6 841.6 941.7 976.8 1007.6 1052.1 27094.6 30678.4 30857.9 31262.5 31444.5 1034.5 1064.3 1155.9 1205.2 1219.5 15048.4 15069.6 15571.7 15930.8 16282.8 701276.0 707470.0 714589.0 716278.0 718068.0 57905.0 59442.0 60088.1 60165.0 60217.1 1386.5 1391.3 1429.2 1452.3 1456.6 29068.0 29524.1 31019.2 31615.0 31989.7 50876.5 51349.5 51354.5 51355.0 51609.5 568394.0 569612.0 570947.0 587934.0 588311.0 27177.5 27298.0 27706.6 27752.9 27853.6 46561.5 46584.8 47015.5 47254.5 47620.5 32521.8 39459.8 39837.2 40117.4 40733.4 39716.8 40160.0 40169.4 40623.0 40757.8 38016.6 38154.0 38688.6 38696.8 39042.0 31101.8 31502.5 34183.8 34624.4 34993.0 25519.4 25655.4 25786.2 26006.0 26114.6 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:33955.02 Median:22154.06 stddev:90387.95 (408.0%) stddev-sans-first:90606.34 17:17:20 INFO - PROCESS | 1655 | Values: 369.5 385.2 394.3 396.8 410.3 19558.4 19919.5 21436.9 22007.9 22355.0 21125.7 21277.9 22123.7 22184.4 22291.9 5668.6 6163.3 6177.7 6183.1 6190.3 4178.2 6053.6 6502.0 6786.2 6810.9 5854.5 6794.9 6807.3 6849.2 6849.9 6115.5 6174.8 6191.0 6209.7 6210.7 5829.1 6008.4 6050.5 6076.1 6093.5 11110.8 12596.3 13390.2 13546.0 13754.9 2196.2 2246.8 2273.6 2575.7 2726.4 10355.6 10829.9 12348.6 15690.1 16390.5 1707.1 1798.3 1895.4 1921.9 1973.1 113402.4 115261.0 116000.0 116981.4 119680.0 11706.9 11708.3 11759.9 11768.3 11769.8 14386.9 14603.7 14870.2 14947.9 15003.5 8659.4 8695.2 8735.2 8765.4 8779.3 8602.1 8610.2 8612.3 8716.8 8776.4 4550.1 4581.2 4653.1 4669.8 4694.6 1785.6 1788.3 1846.4 1914.5 1969.0 929.9 934.0 994.5 997.9 1020.4 21499.2 21543.5 21716.0 21788.0 22069.0 834.5 929.5 954.9 962.3 990.6 11369.5 11560.2 11611.9 11697.3 11706.9 503408.0 511559.0 512056.0 565092.0 574157.0 118377.4 142699.0 150055.0 150458.0 151110.2 890.3 977.5 1005.3 1018.4 1022.0 16762.6 19933.9 20215.6 20230.8 20272.2 55744.4 56389.7 57417.7 57631.8 59572.0 86745.3 87027.0 87199.0 87535.6 88235.1 8153.7 8297.3 8317.5 8408.9 8483.7 12376.9 12523.7 13209.9 13211.2 13519.0 11507.8 11636.4 11714.7 11754.7 11768.6 11279.8 11346.5 11614.9 11634.8 11635.7 10121.0 10909.9 11508.0 11860.2 11934.1 8297.4 8346.0 8402.0 8413.7 8482.0 8375.7 11369.0 11547.8 11620.9 11763.0 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5631.40 Median:4967.28 stddev:3164.21 (63.7%) stddev-sans-first:3158.08 17:17:20 INFO - PROCESS | 1655 | Values: 1530.5 1565.5 1787.2 1825.3 1903.9 7902.9 8284.6 8394.2 8867.5 8975.6 7241.7 8517.7 8638.1 8664.5 8711.5 2316.8 2341.1 2343.3 2346.3 2347.6 2240.0 2300.8 2319.1 2324.8 2333.7 2307.5 2309.3 2310.7 2335.3 2341.4 2284.6 2289.9 2295.6 2307.7 2322.9 1902.0 2256.8 2263.7 2268.3 2269.1 8697.3 8703.1 8821.5 8821.6 8853.8 5141.2 5237.7 5287.2 5294.7 5329.5 3274.6 3336.5 3366.5 3391.9 3543.0 1033.9 1055.5 1062.5 1068.3 1069.5 11483.7 11600.9 11616.4 11621.8 11650.5 4562.3 4614.5 4758.4 4771.2 4781.0 8422.0 9672.6 9821.3 9822.5 9857.1 4535.7 4723.8 5313.4 5324.5 5329.0 3749.5 4137.7 4339.7 4872.8 4886.7 3822.9 3883.9 3909.3 3933.2 3955.2 1211.8 1260.3 1266.2 1274.7 1282.2 808.8 866.3 946.8 968.8 994.2 6057.1 6066.5 6095.5 6140.0 6146.4 428.2 439.8 442.2 443.0 980.6 4034.5 4043.4 4075.9 4101.1 4124.9 10395.5 10593.0 10682.3 10708.9 10802.0 9048.3 9061.5 10533.0 10596.5 10668.0 6614.6 8016.9 8088.5 8161.7 8269.3 5262.2 5611.6 5984.6 6092.7 6183.8 9867.6 9870.6 9883.5 9901.5 10067.0 9891.4 10015.9 10043.0 10226.7 10286.9 6981.2 7371.5 7519.8 7643.7 7698.5 8334.2 8353.2 8395.8 8425.2 8434.1 7372.8 7502.1 7535.7 7572.9 7635.1 7217.7 7263.7 7287.8 7320.5 7330.2 7048.6 7077.1 7119.3 7127.3 7133.8 4859.0 4905.3 5029.2 5037.9 5085.5 5070.7 5144.8 5170.5 5186.9 5280.5 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4403.75 Median:4767.26 stddev:1377.92 (28.9%) stddev-sans-first:1346.25 17:17:20 INFO - PROCESS | 1655 | Values: 261.6 306.1 310.7 320.8 323.4 4234.4 4699.4 5534.0 5657.9 5703.0 5223.9 5538.4 5590.8 5654.7 5658.3 3504.8 3766.5 3820.3 4002.0 4188.5 3853.3 3945.3 3979.6 4250.1 4276.9 3824.4 4160.7 4185.7 4198.6 4219.7 3456.3 3631.5 3859.1 3863.6 4186.9 3299.6 3354.3 3617.8 3627.5 3629.8 4758.6 5126.1 5479.2 5483.2 5498.5 4821.0 4841.0 4843.0 4850.0 4853.3 4929.1 5209.2 5709.5 5959.1 5963.5 2961.6 3971.6 3973.8 3977.5 4023.9 5842.5 5949.8 6055.5 6192.8 6192.9 3496.0 3999.0 4004.8 4009.0 4028.9 3794.6 4061.6 4068.8 4079.4 4098.5 4479.6 4509.3 4685.6 4758.5 4764.1 4571.6 5004.1 5405.9 5674.1 5820.8 1165.0 1171.6 1185.8 1378.2 1397.2 677.8 705.9 715.7 861.3 861.9 3711.2 4037.6 4218.5 4656.6 4657.7 4249.7 4256.7 4998.6 5170.4 5298.8 4007.4 4541.8 4584.1 4659.6 4672.8 2369.5 2552.2 2626.4 2714.4 2764.8 4619.0 4966.0 5347.5 5372.7 5432.4 4851.7 4979.6 5010.8 5262.9 5299.4 4403.6 4471.6 4761.7 5102.6 5378.9 4770.4 5134.4 5161.7 5172.8 5191.3 3924.0 4489.6 4637.0 4903.6 5086.3 4681.0 5013.8 5245.7 5376.0 5397.8 3152.7 3524.9 3539.8 3556.4 3576.2 4568.9 5130.1 5155.3 5162.1 5825.9 4466.6 5054.4 5256.6 5944.3 5984.8 5136.9 5885.2 5901.6 5911.3 5946.6 5489.5 5803.4 5803.8 5907.8 5963.2 5185.9 5316.7 5789.4 6062.0 6068.7 4808.2 5392.4 5774.8 5906.3 5906.9 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:25334.74 Median:3705.52 stddev:41141.93 (1110.3%) stddev-sans-first:41215.82 17:17:20 INFO - PROCESS | 1655 | Values: 716.7 719.3 743.3 754.4 762.9 13794.0 14909.2 15690.5 15714.1 15740.9 11094.8 12095.3 12257.8 12555.7 14698.2 695.7 856.6 878.6 886.5 890.2 837.4 875.6 885.9 889.8 893.1 941.0 941.8 941.9 943.4 950.6 913.2 934.6 936.0 936.2 936.5 650.8 681.4 683.9 695.6 698.2 15488.1 15706.3 15774.3 15848.2 15883.7 13842.4 14395.7 14879.9 14884.4 14887.6 10859.7 11993.5 12256.7 12538.9 12619.3 3736.7 3810.3 4026.0 4047.6 4051.6 123946.8 124812.4 125786.0 126494.0 128317.4 11334.6 11481.8 11565.5 11578.2 12071.8 23937.3 23944.6 23964.6 23971.6 24016.6 8202.5 8236.5 8252.5 8327.6 8440.0 4521.0 4614.2 4621.4 4663.8 4783.0 3575.1 3697.6 3703.9 3707.2 3847.3 631.7 682.0 693.6 702.8 723.4 631.8 686.4 689.0 702.5 710.9 9563.2 9592.4 9713.9 9722.7 9998.9 559.7 656.3 668.5 688.7 690.8 4558.9 4687.9 4730.6 4742.1 4776.7 93859.0 112855.4 146533.8 159851.0 164562.0 140291.3 140349.0 140693.0 142683.3 143085.3 104090.0 120410.4 121679.0 122288.0 123661.4 8832.3 9023.5 9069.1 9098.8 9279.8 57482.7 61375.0 61884.7 63050.0 63375.7 71091.6 85748.0 88831.8 95480.0 98094.0 11892.0 11975.5 12080.3 12372.4 12559.8 13477.9 13488.7 13508.5 13560.5 13564.5 11065.9 12084.6 12213.3 12414.6 12691.6 10369.7 12393.5 12480.3 12626.9 12834.1 12283.7 12289.4 12440.3 13326.7 14327.2 10951.8 11210.0 11264.1 11349.3 11525.4 9493.1 10063.9 10069.3 11772.2 11849.7 17:17:20 INFO - PROCESS | 1655 | -------- Summary: end -------- 17:17:20 INFO - PROCESS | 1655 | 17:17:20 INFO - TEST-INFO | 1655: exit 0 17:17:20 INFO - TEST-OK | dromaeo_css | took 1113475ms 17:17:20 INFO - TEST-START | kraken 17:17:20 INFO - operating with platform_type : mac_ 17:17:20 INFO - Initialising browser for kraken test... 17:17:20 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmprFI0EM/profile http://localhost:49273/getInfo.html) 17:17:23 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 17:17:23 INFO - PROCESS | 1666 | colorDepth:24 17:17:23 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 17:17:23 INFO - PROCESS | 1666 | __metrics 17:17:23 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 17:17:24 INFO - TEST-INFO | 1666: exit 0 17:17:24 INFO - Browser initialized. 17:17:24 INFO - Running cycle 1/1 for kraken test... 17:17:24 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmprFI0EM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:17:36 INFO - PROCESS | 1668 | RSS: Main: 254238720 17:17:36 INFO - PROCESS | 1668 | 17:17:39 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:39 INFO - PROCESS | 1668 | RSS: Main: 267104256 17:17:39 INFO - PROCESS | 1668 | 17:17:42 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 17:17:43 INFO - PROCESS | 1668 | RSS: Main: 271286272 17:17:43 INFO - PROCESS | 1668 | 17:17:46 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 17:17:47 INFO - PROCESS | 1668 | RSS: Main: 271503360 17:17:47 INFO - PROCESS | 1668 | 17:17:49 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 17:17:50 INFO - PROCESS | 1668 | RSS: Main: 272502784 17:17:50 INFO - PROCESS | 1668 | 17:17:52 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:52 INFO - PROCESS | 1668 | RSS: Main: 273141760 17:17:52 INFO - PROCESS | 1668 | 17:17:55 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:56 INFO - PROCESS | 1668 | RSS: Main: 273760256 17:17:56 INFO - PROCESS | 1668 | 17:17:58 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:59 INFO - PROCESS | 1668 | RSS: Main: 273846272 17:17:59 INFO - PROCESS | 1668 | 17:18:02 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 17:18:03 INFO - PROCESS | 1668 | RSS: Main: 274178048 17:18:03 INFO - PROCESS | 1668 | 17:18:04 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:18:05 INFO - PROCESS | 1668 | RSS: Main: 273682432 17:18:05 INFO - PROCESS | 1668 | 17:18:07 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:18:08 INFO - PROCESS | 1668 | RSS: Main: 273752064 17:18:08 INFO - PROCESS | 1668 | 17:18:10 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:18:11 INFO - PROCESS | 1668 | RSS: Main: 273891328 17:18:11 INFO - PROCESS | 1668 | 17:18:14 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:18:14 INFO - PROCESS | 1668 | RSS: Main: 273997824 17:18:14 INFO - PROCESS | 1668 | 17:18:17 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:18:18 INFO - PROCESS | 1668 | RSS: Main: 273870848 17:18:18 INFO - PROCESS | 1668 | 17:18:19 INFO - PROCESS | 1668 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 17:18:20 INFO - PROCESS | 1668 | RSS: Main: 275079168 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | __start_tp_report 17:18:20 INFO - PROCESS | 1668 | _x_x_mozilla_page_load 17:18:20 INFO - PROCESS | 1668 | _x_x_mozilla_page_load_details 17:18:20 INFO - PROCESS | 1668 | |i|pagename|runs| 17:18:20 INFO - PROCESS | 1668 | |0;ai-astar;103;115;106;115;116;121;113;114;116;115 17:18:20 INFO - PROCESS | 1668 | |1;audio-beat-detection;146;110;120;184;144;165;134;113;157;110 17:18:20 INFO - PROCESS | 1668 | |2;audio-dft;273;258;195;205;233;197;195;218;203;275 17:18:20 INFO - PROCESS | 1668 | |3;audio-fft;70;71;75;162;86;73;58;65;159;83 17:18:20 INFO - PROCESS | 1668 | |4;audio-oscillator;70;72;117;72;73;97;117;71;73;115 17:18:20 INFO - PROCESS | 1668 | |5;imaging-gaussian-blur;90;86;90;87;90;87;90;87;91;81 17:18:20 INFO - PROCESS | 1668 | |6;imaging-darkroom;95;96;94;97;95;97;95;100;95;94 17:18:20 INFO - PROCESS | 1668 | |7;imaging-desaturate;115;122;102;99;77;150;129;143;155;144 17:18:20 INFO - PROCESS | 1668 | |8;json-parse-financial;58;56;57;58;55;57;58;56;56;58 17:18:20 INFO - PROCESS | 1668 | |9;json-stringify-tinderbox;66;68;77;68;78;67;88;101;108;93 17:18:20 INFO - PROCESS | 1668 | |10;stanford-crypto-aes;89;82;86;83;88;84;85;88;87;81 17:18:20 INFO - PROCESS | 1668 | |11;stanford-crypto-ccm;146;127;177;154;152;158;136;140;194;134 17:18:20 INFO - PROCESS | 1668 | |12;stanford-crypto-pbkdf2;167;167;168;167;167;162;167;166;166;166 17:18:20 INFO - PROCESS | 1668 | |13;stanford-crypto-sha256-iterative;67;69;67;67;65;74;86;95;85;89 17:18:20 INFO - PROCESS | 1668 | __end_tp_report 17:18:20 INFO - PROCESS | 1668 | __start_cc_report 17:18:20 INFO - PROCESS | 1668 | _x_x_mozilla_cycle_collect,1144 17:18:20 INFO - PROCESS | 1668 | __end_cc_report 17:18:20 INFO - PROCESS | 1668 | __startTimestamp1468282700108__endTimestamp 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | ------- Summary: start ------- 17:18:20 INFO - PROCESS | 1668 | Number of tests: 14 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#0] ai-astar Cycles:10 Average:113.40 Median:115.00 stddev:5.19 (4.5%) stddev-sans-first:3.91 17:18:20 INFO - PROCESS | 1668 | Values: 103.0 115.0 106.0 115.0 116.0 121.0 113.0 114.0 116.0 115.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:145.00 stddev:25.47 (17.6%) stddev-sans-first:26.86 17:18:20 INFO - PROCESS | 1668 | Values: 146.0 110.0 120.0 184.0 144.0 165.0 134.0 113.0 157.0 110.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#2] audio-dft Cycles:10 Average:225.20 Median:225.50 stddev:32.44 (14.4%) stddev-sans-first:29.44 17:18:20 INFO - PROCESS | 1668 | Values: 273.0 258.0 195.0 205.0 233.0 197.0 195.0 218.0 203.0 275.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#3] audio-fft Cycles:10 Average:90.20 Median:72.00 stddev:37.91 (52.7%) stddev-sans-first:39.50 17:18:20 INFO - PROCESS | 1668 | Values: 70.0 71.0 75.0 162.0 86.0 73.0 58.0 65.0 159.0 83.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:72.00 stddev:21.26 (29.5%) stddev-sans-first:21.56 17:18:20 INFO - PROCESS | 1668 | Values: 70.0 72.0 117.0 72.0 73.0 97.0 117.0 71.0 73.0 115.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:90.00 stddev:3.00 (3.3%) stddev-sans-first:3.08 17:18:20 INFO - PROCESS | 1668 | Values: 90.0 86.0 90.0 87.0 90.0 87.0 90.0 87.0 91.0 81.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:95.00 stddev:1.81 (1.9%) stddev-sans-first:1.90 17:18:20 INFO - PROCESS | 1668 | Values: 95.0 96.0 94.0 97.0 95.0 97.0 95.0 100.0 95.0 94.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#7] imaging-desaturate Cycles:10 Average:123.60 Median:147.00 stddev:25.44 (17.3%) stddev-sans-first:26.79 17:18:20 INFO - PROCESS | 1668 | Values: 115.0 122.0 102.0 99.0 77.0 150.0 129.0 143.0 155.0 144.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.10 (1.9%) stddev-sans-first:1.09 17:18:20 INFO - PROCESS | 1668 | Values: 58.0 56.0 57.0 58.0 55.0 57.0 58.0 56.0 56.0 58.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#9] json-stringify-tinderbox Cycles:10 Average:81.40 Median:72.50 stddev:15.29 (21.1%) stddev-sans-first:15.17 17:18:20 INFO - PROCESS | 1668 | Values: 66.0 68.0 77.0 68.0 78.0 67.0 88.0 101.0 108.0 93.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.50 stddev:2.75 (3.2%) stddev-sans-first:2.57 17:18:20 INFO - PROCESS | 1668 | Values: 89.0 82.0 86.0 83.0 88.0 84.0 85.0 88.0 87.0 81.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#11] stanford-crypto-ccm Cycles:10 Average:151.80 Median:153.00 stddev:20.58 (13.5%) stddev-sans-first:21.73 17:18:20 INFO - PROCESS | 1668 | Values: 146.0 127.0 177.0 154.0 152.0 158.0 136.0 140.0 194.0 134.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:167.00 stddev:1.64 (1.0%) stddev-sans-first:1.72 17:18:20 INFO - PROCESS | 1668 | Values: 167.0 167.0 168.0 167.0 167.0 162.0 167.0 166.0 166.0 166.0 17:18:20 INFO - PROCESS | 1668 | 17:18:20 INFO - PROCESS | 1668 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:79.50 stddev:11.19 (14.1%) stddev-sans-first:11.34 17:18:20 INFO - PROCESS | 1668 | Values: 67.0 69.0 67.0 67.0 65.0 74.0 86.0 95.0 85.0 89.0 17:18:20 INFO - PROCESS | 1668 | -------- Summary: end -------- 17:18:20 INFO - PROCESS | 1668 | 17:18:21 INFO - TEST-INFO | 1668: exit 0 17:18:21 INFO - TEST-OK | kraken | took 60394ms 17:18:21 INFO - SUITE-END | took 1173s 17:18:21 INFO - Completed test suite (00:19:34) 17:18:21 INFO - javascript benchmark 17:18:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7376.231619946563, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3423.5720534933134, 3445.2937147884686, 3466.8093254870987, 3471.722262219023, 3488.4418493041103, 5124.0, 5461.49808802579, 5851.327097383797, 5945.732442040107, 6014.789482368118, 5775.451332123452, 5937.2578427696535, 5958.821235362946, 6002.8499287517725, 6111.083337499377, 4332.306830907056, 5308.283381743454, 5326.201069839516, 5372.54333381663, 5398.514133727964, 5285.365756109272, 5410.621256512046, 5451.073317536028, 5498.697571633558, 5505.064139096363, 5164.328637277167, 5361.276227709248, 5373.274607927919, 5393.703346315951, 5410.783568657249, 5201.0, 5260.92108618371, 5261.158214685632, 5295.073362161645, 5298.36419629643, 4545.795439205243, 5186.948130518722, 5236.7905283788605, 5274.841754747364, 5305.893882122375, 5736.827895163152, 5788.942110578882, 5852.0, 5907.0, 5960.254968128984, 6240.095186198021, 6288.182536270256, 6297.0, 6315.810525684236, 6321.778737744203, 6347.523935704794, 6357.713902874381, 6363.968180159116, 6377.947638639619, 6389.808305750835, 5796.362400135981, 5946.8810623787285, 5957.195778569924, 5998.130271110665, 6009.819705408845, 6430.710618022106, 6489.837754056092, 6491.51313651478, 6498.837529061717, 6509.414152726277, 6219.533534984895, 6273.153124328249, 6283.434490895841, 6286.214223222098, 6295.622262664255, 6165.0, 6180.289266734293, 6199.721012554446, 6215.285242197115, 6254.968725156436, 6134.252905685562, 6222.973209420486, 6251.718672659741, 6260.123582698426, 6264.091706702503, 5460.0, 6071.5565643292075, 6276.968615156895, 6279.780207692709, 6315.463185629273, 4542.613877820356, 4925.482824303468, 4928.852134435972, 4983.975080124576, 4991.251312303184, 4425.535318791481, 4444.933326000112, 4455.22033644111, 4473.329000649928, 4505.301678239878, 5780.132980053026, 5869.8239052828485, 5876.236089308448, 5876.676782776988, 5904.586678932434, 6230.190075290274, 6241.313455519889, 6334.1765570475545, 6334.334894836068, 6365.713542890581, 5996.550258730613, 5996.940030599638, 6025.126356678345, 6025.4577088061405, 6040.044770550927, 5424.918626220609, 5493.615446918678, 5557.41647127054, 5558.166275058774, 5607.607467477319, 6415.518836087312, 6541.182352205974, 6542.672866356568, 6549.6070235786, 6563.212414510289, 6332.841678957879, 6334.081558173947, 6350.555461117678, 6367.554271200971, 6370.904436433365, 6151.784687535915, 6442.516811239082, 6457.515686323639, 6536.869262614626, 6650.933490665031, 6255.31191568918, 6284.057391391328, 6292.402221788922, 6303.716332765129, 6329.461995730415, 5277.894442111059, 5307.681539107666, 6325.367463253638, 6355.87288254223, 6367.458766004941, 5545.306836645419, 6100.187591190105, 6122.733612273432, 6139.877202455837, 6206.379362063757, 6176.598521096114, 6224.439800417984, 6246.750129994749, 6261.530385221035, 6271.62370257786, 5278.630495865253, 6099.451049405575, 6110.388961103854, 6188.504919606511, 6198.2871969722255, 4921.311016457627, 5518.613697041169, 6181.876362472815, 6190.566660333913, 6283.403076707888, 5551.861203469945, 5775.480206781242, 6196.969015154896, 6197.411245931629, 6209.906851397142], "value": 5768.082736457366, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.42713884047396, 503.46381104124106, 504.5207053299367, 526.4893053737873, 526.9288646032782, 33014.50478242825, 37315.62684373155, 39419.60580394195, 39595.40606890892, 39663.206735865264, 41396.79301603488, 41846.79076604613, 41853.9073046348, 41973.74078777634, 41978.58021419785, 8676.609552570118, 8760.299176065899, 8808.867866982, 8817.162369574913, 8819.250363719091, 9625.518724063804, 9737.610495580167, 9744.0, 9759.609615615367, 9765.609375624967, 9705.854412183822, 9740.853887191663, 9754.219662426989, 9786.853197202048, 9805.460699661517, 9661.855072173923, 9663.323567350288, 9702.466364349957, 9714.0, 9725.854112188323, 9564.808703825884, 9632.27757918152, 9642.807143857153, 9648.469334186617, 9650.565724542343, 39573.0, 39731.20537589261, 39799.60200397988, 40064.59935400638, 40292.19415611671, 3552.6802587767224, 3655.780653160819, 3674.228412033476, 3681.9815900920594, 4144.91710165798, 31061.378772424425, 32912.67087329144, 32971.340573188405, 32995.83502082474, 33001.6699833001, 3231.2891163943896, 3435.811030393327, 3462.117160124177, 3464.6188919219117, 3467.271872906693, 467233.0, 471035.0, 476206.0, 476381.0, 482854.0, 68782.65608672025, 69605.30394696089, 69705.65147174231, 69753.0, 69804.0, 69079.61840763157, 70370.64814675893, 71033.64483177655, 71571.64214178895, 72068.63965680244, 16703.0, 16739.33042678279, 16970.236339364757, 16979.405720799714, 17037.57406064858, 11739.354335511458, 12017.798220177912, 12020.97821685149, 12962.80555791645, 12967.935160324138, 16247.431339903047, 16419.58951026234, 18249.726254106197, 19924.0, 20017.199312027646, 8697.130286971253, 8892.3330750194, 8912.242459391024, 8935.195832375117, 8955.641774328953, 841.5750046226616, 941.6562954521687, 976.7899901521065, 1007.5516395204064, 1052.074174726236, 27094.5935810963, 30678.38643227123, 30857.919972801294, 31262.531062034086, 31444.52833207504, 1034.5086084109987, 1064.2869277584036, 1155.8786327435666, 1205.2045649871043, 1219.4634760202032, 15048.398064077533, 15069.623259418602, 15571.688566228839, 15930.761038584431, 16282.75575866363, 701276.0, 707470.0, 714589.0, 716278.0, 718068.0, 57905.0, 59442.0, 60088.098678519855, 60165.0, 60217.09674354888, 1386.4939297156666, 1391.2973948156116, 1429.2139323372103, 1452.3028946105928, 1456.6285597172864, 29068.0, 29524.114276571738, 31019.224519387197, 31615.0, 31989.6801031996, 50876.491235087175, 51349.48650513597, 51354.48645513497, 51355.0, 51609.48390516197, 568394.0, 569612.0, 570947.0, 587934.0, 588311.0, 27177.45645087127, 27298.0, 27706.584401234402, 27752.861235693694, 27853.582196267478, 46561.53438465572, 46584.767076164404, 47015.529844701116, 47254.527454725016, 47620.523794762994, 32521.837390812896, 39459.802700986314, 39837.203255935296, 40117.39823902585, 40733.38899916563, 39716.80141599273, 40159.99600010023, 40169.39745903872, 40623.0, 40757.79621101876, 38016.61983380241, 38154.0461488465, 38688.6131138685, 38696.80651596724, 39042.0, 31101.844490777403, 31502.527462088547, 34183.80356687504, 34624.36813665659, 34993.0, 25519.36201594975, 25655.358616034748, 25786.226413207634, 26006.0, 26114.63386778803], "value": 20454.00329143431, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4974834225454, 385.17572395074546, 394.2765026176965, 396.81151453059783, 410.3475473996347, 19558.41324760256, 19919.502012449695, 21436.89281553594, 22007.889960550216, 22355.0, 21125.68311475329, 21277.893610531926, 22123.668144977797, 22184.445388865286, 22291.888540557316, 5668.631538949965, 6163.2604087509335, 6177.66022868742, 6183.072539119124, 6190.288116866551, 4178.164367126572, 6053.606515576474, 6501.967490162542, 6786.219584747743, 6810.897836532431, 5854.473097421232, 6794.932050679504, 6807.319268073178, 6849.2465828758795, 6849.931500685004, 6115.510759139258, 6174.8147555573405, 6190.999999999977, 6209.689515524251, 6210.689465526728, 5829.125631155318, 6008.399160084, 6050.485708714765, 6076.118962750421, 6093.482054025413, 11110.777784444346, 12596.307203103826, 13390.196588204739, 13546.0, 13754.93122534391, 2196.1544805249932, 2246.820419279875, 2273.624851899435, 2575.742425757428, 2726.4274502354333, 10355.585776568929, 10829.891701082966, 12348.567800127043, 15690.058596484247, 16390.508284751475, 1707.1464267866068, 1798.2806877249204, 1895.4124221491381, 1921.8750781199178, 1973.0923775063488, 113402.43298783453, 115261.0, 116000.0, 116981.41509292484, 119680.0, 11706.88293117058, 11708.297502149899, 11759.941200293944, 11768.293902365886, 11769.823452648217, 14386.928065359607, 14603.707925841423, 14870.182139982406, 14947.850521494645, 15003.474878379204, 8659.350548708746, 8695.217430431292, 8735.1701588349, 8765.430247033923, 8779.29765618749, 8602.096779838152, 8610.182032707007, 8612.311015118776, 8716.782080447912, 8776.429532080394, 4550.089982003613, 4581.2440947243995, 4653.115907977473, 4669.766511674403, 4694.624430045588, 1785.5893144576821, 1788.320438233463, 1846.3537761783268, 1914.5405102775233, 1968.95645307987, 929.8837645294203, 933.9533023348805, 994.5126887825058, 997.8503224516236, 1020.4489575629077, 21499.2475263365, 21543.461413464476, 21716.0, 21788.0, 22069.0, 834.4826207751233, 929.4748467116193, 954.8758661374115, 962.3407965543626, 990.5740531571349, 11369.488373023234, 11560.248583842023, 11611.941940290413, 11697.2981621103, 11706.941465292619, 503408.0, 511559.0, 512056.0, 565092.0, 574157.0, 118377.40811295889, 142699.0, 150055.0, 150458.0, 151110.24444877924, 890.3100097424548, 977.4917043137671, 1005.3113617172261, 1018.3889666200369, 1021.9693409197736, 16762.58093547671, 19933.900330498836, 20215.59568808645, 20230.79769202289, 20272.18911243534, 55744.442555575544, 56389.71805140948, 57417.71291143518, 57631.84736305167, 59572.0, 86745.26509469649, 87027.0, 87199.0, 87535.56232218798, 88235.11764882525, 8153.714619988509, 8297.25324720778, 8317.459365141247, 8408.87386689188, 8483.74548763538, 12376.858319899668, 12523.74952500963, 13209.867901321248, 13211.207327560378, 13519.0, 11507.827382589436, 11636.41817909118, 11714.70713232176, 11754.70613234676, 11768.646940591796, 11279.774404512027, 11346.546138154381, 11614.88385116138, 11634.825477617673, 11635.709107272047, 10121.0, 10909.945450272699, 11508.0, 11860.229085109786, 11934.104942129201, 8297.377696672653, 8345.95827020861, 8401.99176098872, 8413.747587572383, 8482.0, 8375.706850260212, 11369.0, 11547.769044618892, 11620.941895290469, 11763.0], "value": 9754.114571046559, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.4796369234457, 1565.4677409680705, 1787.213626004558, 1825.2698920431833, 1903.876248043876, 7902.920970790305, 8284.585770711456, 8394.244517993387, 8867.467951922881, 8975.551222438884, 7241.67412466439, 8517.659293628247, 8638.09300023498, 8664.523451210182, 8711.520866352364, 2316.837821352506, 2341.075275266269, 2343.3087239264373, 2346.3312955807596, 2347.58917189492, 2239.9552008959813, 2300.8274379421528, 2319.095552734435, 2324.8256380771427, 2333.673285739998, 2307.5038866643667, 2309.3187509684685, 2310.7342655594653, 2335.252719129879, 2341.3912382780513, 2284.6230371988604, 2289.8855057247238, 2295.6097463431174, 2307.6538519222167, 2322.883855807203, 1901.9809801901943, 2256.796888280063, 2263.6830843681896, 2268.3081660093667, 2269.0923630547913, 8697.347698922544, 8703.129687031309, 8821.51481668508, 8821.60302786376, 8853.848999630007, 5141.177411614161, 5237.659552129099, 5287.180487024518, 5294.655847369909, 5329.467053294678, 3274.5579346788118, 3336.4995250712345, 3366.4613661814237, 3391.915202119942, 3543.0, 1033.9017793309624, 1055.4933631856675, 1062.5484169228048, 1068.3376306689902, 1069.4813015687384, 11483.712907177303, 11600.94199528997, 11616.419179041099, 11621.825672614917, 11650.47572859215, 4562.270036794163, 4614.538546145426, 4758.405199350082, 4771.212749896297, 4781.0, 8422.0, 9672.56473458682, 9821.312508124363, 9822.508874556244, 9857.063578959987, 4535.705179163344, 4723.811047558128, 5313.388960269541, 5324.547413469899, 5329.0, 3749.4938183345444, 4137.731047481904, 4339.7396156230725, 4872.756362181876, 4886.657933944661, 3822.9426558601645, 3883.922321553553, 3909.3354129798004, 3933.1936952925153, 3955.1806169161932, 1211.7758214730304, 1260.3257257367266, 1266.2402558464848, 1274.6940734223906, 1282.2114399644338, 808.8058865872148, 866.3112825303898, 946.8059047895302, 968.7965527239218, 994.16986816008, 6057.121717350959, 6066.48434883031, 6095.542834287447, 6140.048292514667, 6146.354632763496, 428.1949934123827, 439.7845055922575, 442.2106539826394, 442.98671039868856, 980.5979548385128, 4034.5158580969883, 4043.3732771420478, 4075.9388609170887, 4101.138760860253, 4124.938125928114, 10395.532201050972, 10593.0, 10682.252242343116, 10708.946455267675, 10802.027817496462, 9048.276137908952, 9061.54692265384, 10533.0, 10596.470176491144, 10668.0, 6614.570052946543, 8016.879746803803, 8088.474249173785, 8161.673533058611, 8269.338452923632, 5262.236975638588, 5611.551075913999, 5984.581079324405, 6092.664903430176, 6183.81448556544, 9867.605295788375, 9870.555824987749, 9883.456409897524, 9901.504924753877, 10067.0, 9891.406515609087, 10015.948325426018, 10043.0, 10226.744331391776, 10286.948565257126, 6981.162260528769, 7371.520851144658, 7519.796832506772, 7643.694252230071, 7698.538087714755, 8334.249917507212, 8353.20644538768, 8395.790105247417, 8425.199606037417, 8434.072252052147, 7372.815679608053, 7502.062242219723, 7535.660895259617, 7572.924270757222, 7635.083789945242, 7217.711291548279, 7263.709451621876, 7287.781366559012, 7320.524165929198, 7330.230325815925, 7048.612326322102, 7077.115360579927, 7119.323664251888, 7127.322904324081, 7133.82165445868, 4858.975705121452, 4905.313256144214, 5029.245613158056, 5037.949620503895, 5085.542301192911, 5070.746462676925, 5144.76848541824, 5170.457102004236, 5186.870328241824, 5280.471952804689], "value": 4477.128808374097, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.64416393704556, 306.1122744042277, 310.6691373687023, 320.79629435308584, 323.3871812914526, 4234.407182994383, 4699.3683537219185, 5534.0, 5657.886842263158, 5703.001974654435, 5223.921641175376, 5538.39695343188, 5590.804321848736, 5654.660720356771, 5658.264425624663, 3504.8072356020407, 3766.5291838520184, 3820.2932457495313, 4002.0395105174694, 4188.518320393148, 3853.3064048471265, 3945.329294020009, 3979.5622481527007, 4250.06498570314, 4276.935845962297, 3824.374640777672, 4160.687948403866, 4185.686073544481, 4198.580141985807, 4219.662427005832, 3456.343294773985, 3631.473436351714, 3859.0545316397383, 3863.613638636142, 4186.91626167475, 3299.5875515560556, 3354.289312450643, 3617.801020943847, 3627.4921510988484, 3629.818509074562, 4758.643101767347, 5126.078135462788, 5479.150731636602, 5483.232347471358, 5498.505134537871, 4820.951790482085, 4840.9515904840855, 4842.951570484321, 4849.9757501212625, 4853.320535125085, 4929.112759703252, 5209.1665333546825, 5709.457601527848, 5959.109831731606, 5963.463288304073, 2961.6446026476747, 3971.5631280559114, 3973.7615743055508, 3977.548194908866, 4023.879283621496, 5842.503387212092, 5949.8215053548465, 6055.485283750886, 6192.81421557354, 6192.938070619326, 3496.0, 3998.9605301296547, 4004.7797371144284, 4009.0, 4028.871915863563, 3794.6395092466173, 4061.5532291447917, 4068.8372465101656, 4079.449274347925, 4098.508179018537, 4479.552044795494, 4509.302372054884, 4685.625149988061, 4758.500357462486, 4764.094821983812, 4571.634269258518, 5004.099262132851, 5405.918911216335, 5674.148877668383, 5820.796272130455, 1164.976700465986, 1171.6075114836626, 1185.7924863149087, 1378.2488543743684, 1397.224540380099, 677.7729460630645, 705.8870580707062, 715.7387553542919, 861.2894362151251, 861.8621020636668, 3711.202091550276, 4037.555868854424, 4218.451601291812, 4656.604188644003, 4657.6506761992305, 4249.745015299092, 4256.723312984646, 4998.600951353043, 5170.37955445349, 5298.788048478094, 4007.4189242560246, 4541.818327266872, 4584.0806110775475, 4659.58063774262, 4672.789724462407, 2369.5308908476854, 2552.205335157999, 2626.3565426470636, 2714.4164004739077, 2764.8064635475325, 4618.983823558811, 4966.0, 5347.491988261187, 5372.704501252469, 5432.387462337501, 4851.708897466164, 4979.551840334388, 5010.824621138243, 5262.9474105179115, 5299.3905700844125, 4403.625691816167, 4471.61991230749, 4761.714297142183, 5102.617303702237, 5378.892422151535, 4770.4275486940405, 5134.405915858839, 5161.683770638463, 5172.793088276427, 5191.312823332508, 3924.0, 4489.565482405897, 4636.953630463652, 4903.567502748162, 5086.32151390033, 4681.0, 5013.824516141917, 5245.6918955659385, 5376.0, 5397.815288979521, 3152.6689697581423, 3524.8766293179615, 3539.7876127432437, 3556.4309710446205, 3576.2311103112957, 4568.908621827612, 5130.12787826078, 5155.32980712505, 5162.09663308912, 5825.94174058254, 4466.64266858657, 5054.418741844588, 5256.6320357574605, 5944.3164036136395, 5984.760609575743, 5136.948630513796, 5885.205497257815, 5901.616394934315, 5911.344823449441, 5946.583739138392, 5489.533389661923, 5803.361630220588, 5803.767849285981, 5907.788903274733, 5963.224780778644, 5185.870353241048, 5316.680999140064, 5789.3658385435365, 6062.0, 6068.666223357758, 4808.206645903387, 5392.433794451683, 5774.787294668166, 5906.316699740553, 5906.940930590639], "value": 3960.814417571426, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.7491378017692, 719.3310221494011, 743.2790193512297, 754.4040208235494, 762.870312046952, 13794.0, 14909.179995100265, 15690.45083422082, 15714.135722535257, 15740.921295393522, 11094.778104437906, 12095.274283542994, 12257.816132758016, 12555.748885022294, 14698.191599462025, 695.7112798188771, 856.614523464442, 878.5870640798814, 886.4769785826361, 890.2343984173606, 837.3719710217337, 875.6453636277317, 885.8848349714528, 889.7864512517014, 893.0578239956843, 941.0025373104497, 941.7598512379334, 941.9105185007447, 943.4056544377067, 950.6340059077236, 913.1963871792813, 934.5887809363858, 935.9953200234023, 936.2042264075516, 936.5410948635154, 650.7852408705116, 681.3765404654735, 683.9159931508565, 695.5513693667556, 698.2249702829855, 15488.07071575709, 15706.293216805272, 15774.290156942965, 15848.207589620588, 15883.682326353524, 13842.446302147902, 14395.71208575833, 14879.851201487954, 14884.404623815035, 14887.627809304853, 10859.696836379684, 11993.460294286779, 12256.693582660415, 12538.937305313506, 12619.305938173396, 3736.6823819975334, 3810.295095407331, 4026.0, 4047.55476897544, 4051.5948405159543, 123946.76053239443, 124812.37593811973, 125786.0, 126494.0, 128317.35841320733, 11334.610155699647, 11481.770364592661, 11565.537378504765, 11578.189526733047, 12071.75856482883, 23937.281881543582, 23944.640830387558, 23964.64053039206, 23971.640425393634, 24016.63975040376, 8202.548859812767, 8236.464629799044, 8252.546109964009, 8327.583620819056, 8439.957800211083, 4520.95479045212, 4614.1694494991225, 4621.4223222097235, 4663.766811659403, 4783.043391321749, 3575.106223444139, 3697.574778900407, 3703.870364537282, 3707.1658876753054, 3847.2690188864026, 631.6557476175495, 681.9693113809791, 693.6358411833727, 702.8137543550963, 723.3959643697466, 631.7630888416844, 686.3959715450471, 688.9862202755917, 702.5328156775789, 710.9217986021533, 9563.234941204686, 9592.376495527908, 9713.854292185622, 9722.659706910224, 9998.900560714088, 559.7247190171938, 656.3403779201872, 668.5320275806955, 688.6935313785317, 690.7858563845224, 4558.8632341029825, 4687.929681054787, 4730.550597693214, 4742.07529531738, 4776.713397196179, 93859.0, 112855.43572282085, 146533.8019929702, 159851.0, 164562.0, 140291.29854350662, 140349.0, 140693.0, 142683.28658356643, 143085.28457357647, 104090.0, 120410.3979480097, 121679.0, 122288.0, 123661.38169309276, 8832.293416526534, 9023.503707296162, 9069.138431848964, 9098.772530686521, 9279.76800579991, 57482.7125864368, 61375.0, 61884.690576546825, 63050.0, 63375.732485350956, 71091.64454177696, 85748.0, 88831.7792055178, 95480.0, 98094.0, 11892.0, 11975.461104250504, 12080.335581542748, 12372.381380931098, 12559.80268827314, 13477.865221347662, 13488.662783430493, 13508.459661613426, 13560.45758169662, 13564.525241616891, 11065.944670276596, 12084.643325145309, 12213.267203967791, 12414.565490207799, 12691.619251422102, 10369.74075648115, 12393.504259829506, 12480.313582753035, 12626.936865315614, 12834.101612887009, 12283.69290767738, 12289.446974885972, 12440.31578263168, 13326.666833329244, 14327.212003339917, 10951.83572246401, 11210.0, 11264.063864288388, 11349.262297950607, 11525.423728813357, 9493.05069493045, 10063.89936100659, 10069.295149339476, 11772.234804737665, 11849.703757405789], "value": 7891.800201217964, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 106.0, 115.0, 116.0, 121.0, 113.0, 114.0, 116.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 120.0, 184.0, 144.0, 165.0, 134.0, 113.0, 157.0, 110.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [273.0, 258.0, 195.0, 205.0, 233.0, 197.0, 195.0, 218.0, 203.0, 275.0], "value": 225.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 75.0, 162.0, 86.0, 73.0, 58.0, 65.0, 159.0, 83.0], "value": 90.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 117.0, 72.0, 73.0, 97.0, 117.0, 71.0, 73.0, 115.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 87.0, 90.0, 87.0, 90.0, 87.0, 91.0, 81.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 97.0, 95.0, 97.0, 95.0, 100.0, 95.0, 94.0], "value": 95.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 122.0, 102.0, 99.0, 77.0, 150.0, 129.0, 143.0, 155.0, 144.0], "value": 123.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 57.0, 58.0, 55.0, 57.0, 58.0, 56.0, 56.0, 58.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 77.0, 68.0, 78.0, 67.0, 88.0, 101.0, 108.0, 93.0], "value": 81.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 86.0, 83.0, 88.0, 84.0, 85.0, 88.0, 87.0, 81.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 127.0, 177.0, 154.0, 152.0, 158.0, 136.0, 140.0, 194.0, 134.0], "value": 151.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 167.0, 168.0, 167.0, 167.0, 162.0, 167.0, 166.0, 166.0, 166.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 67.0, 67.0, 65.0, 74.0, 86.0, 95.0, 85.0, 89.0], "value": 76.4, "unit": "score"}]}]} 17:18:21 INFO - Return code: 0 17:18:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:18:21 ERROR - # TBPL SUCCESS # 17:18:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:18:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:18:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:18:21 INFO - 2016-07-11 17:18:21.400 screenresolution[1673:10435] starting screenresolution argv=screenresolution get 17:18:21 INFO - 2016-07-11 17:18:21.403 screenresolution[1673:10435] Display 0: 1600x1200x32@60 17:18:21 INFO - 2016-07-11 17:18:21.409 screenresolution[1674:10438] starting screenresolution argv=screenresolution list 17:18:21 INFO - Available Modes on Display 0 17:18:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:18:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:18:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:18:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:18:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:18:21 INFO - Intel Iris: 17:18:21 INFO - Chipset Model: Intel Iris 17:18:21 INFO - Type: GPU 17:18:21 INFO - Bus: Built-In 17:18:21 INFO - VRAM (Dynamic, Max): 1536 MB 17:18:21 INFO - Vendor: Intel (0x8086) 17:18:21 INFO - Device ID: 0x0a2e 17:18:21 INFO - Revision ID: 0x0009 17:18:21 INFO - Displays: 17:18:21 INFO - Display: 17:18:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:18:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:18:21 INFO - Display Serial Number: 1600x1200 60 17:18:21 INFO - Main Display: Yes 17:18:21 INFO - Mirror: Off 17:18:21 INFO - Online: Yes 17:18:21 INFO - Rotation: Supported 17:18:21 INFO - Return code: 0 17:18:21 INFO - Running post-action listener: _resource_record_post_action 17:18:21 INFO - ##### 17:18:21 INFO - ##### Finished run-tests step (success) 17:18:21 INFO - ##### 17:18:21 INFO - Running post-run listener: _resource_record_post_run 17:18:21 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 37200384; Write bytes: 706799616; Read time: 373; Write time: 2083 17:18:21 INFO - TinderboxPrint: CPU usage
54.4% 17:18:21 INFO - TinderboxPrint: I/O read bytes / time
37,200,384 / 373 17:18:21 INFO - TinderboxPrint: I/O write bytes / time
706,799,616 / 2,083 17:18:21 INFO - TinderboxPrint: CPU idle
2,208.0 (45.6%) 17:18:21 INFO - TinderboxPrint: CPU system
976.2 (20.2%) 17:18:21 INFO - TinderboxPrint: CPU user
1,653.4 (34.2%) 17:18:21 INFO - TinderboxPrint: Swap in / out
444,456,960 / 0 17:18:21 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 389720576; Write bytes: 384149504; Read time: 29029; Write time: 688 17:18:21 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 36241920; Write bytes: 297512960; Read time: 358; Write time: 1347 17:18:22 INFO - Running post-run listener: _upload_blobber_files 17:18:22 INFO - Blob upload gear active. 17:18:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:18: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 17:18: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'] 17:18: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 17:18:22 INFO - (blobuploader) - INFO - Open directory for files ... 17:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:18:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:23 INFO - (blobuploader) - INFO - Done attempting. 17:18:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:18:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:24 INFO - (blobuploader) - INFO - Done attempting. 17:18:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:18:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:18:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:18:26 INFO - (blobuploader) - INFO - Done attempting. 17:18:26 INFO - (blobuploader) - INFO - Iteration through files over. 17:18:26 INFO - Return code: 0 17:18:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:18:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:18:26 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d656ce79c96d89b21ddc2dfb26f864e8f34b256c7e84f47ce28220ac6f48a58bf8c925f9e967f4639e7d3fd5a2b978512e89b41b7272625782ce14b1cae5d310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd50e744dbdb5e8e3b70fd25153acd598d28887178ebc23c9b970e29e8c78026fb068b81a99e38ed99dba2dd7250e0cd4702f28013437c8dc044820b44e64b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4b440522c8ff5953a1f5cbf281761a3413a4501708c643e01fe01cd62ac6fa74d6a8fb4d29aea573a59f9e913468c2a6dd1bd32be211d183f9735e0216b2d2e"} 17:18:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:18:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:18:26 INFO - Contents: 17:18:26 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d656ce79c96d89b21ddc2dfb26f864e8f34b256c7e84f47ce28220ac6f48a58bf8c925f9e967f4639e7d3fd5a2b978512e89b41b7272625782ce14b1cae5d310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd50e744dbdb5e8e3b70fd25153acd598d28887178ebc23c9b970e29e8c78026fb068b81a99e38ed99dba2dd7250e0cd4702f28013437c8dc044820b44e64b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4b440522c8ff5953a1f5cbf281761a3413a4501708c643e01fe01cd62ac6fa74d6a8fb4d29aea573a59f9e913468c2a6dd1bd32be211d183f9735e0216b2d2e"} 17:18:26 INFO - Running post-run listener: copy_logs_to_upload_dir 17:18:26 INFO - Copying logs to upload dir... 17:18:26 INFO - mkdir: /builds/slave/test/build/upload/logs 17:18:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.616011 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-07-11 17:18:26.638347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 17:18:26.641770) ========= 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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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/d656ce79c96d89b21ddc2dfb26f864e8f34b256c7e84f47ce28220ac6f48a58bf8c925f9e967f4639e7d3fd5a2b978512e89b41b7272625782ce14b1cae5d310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd50e744dbdb5e8e3b70fd25153acd598d28887178ebc23c9b970e29e8c78026fb068b81a99e38ed99dba2dd7250e0cd4702f28013437c8dc044820b44e64b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4b440522c8ff5953a1f5cbf281761a3413a4501708c643e01fe01cd62ac6fa74d6a8fb4d29aea573a59f9e913468c2a6dd1bd32be211d183f9735e0216b2d2e"} build_url:https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011001 build_url: 'https://queue.taskcluster.net/v1/task/Mb6GIrwpQVq5E_Zp2CV-Tw/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/d656ce79c96d89b21ddc2dfb26f864e8f34b256c7e84f47ce28220ac6f48a58bf8c925f9e967f4639e7d3fd5a2b978512e89b41b7272625782ce14b1cae5d310", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/dd50e744dbdb5e8e3b70fd25153acd598d28887178ebc23c9b970e29e8c78026fb068b81a99e38ed99dba2dd7250e0cd4702f28013437c8dc044820b44e64b26", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/e4b440522c8ff5953a1f5cbf281761a3413a4501708c643e01fe01cd62ac6fa74d6a8fb4d29aea573a59f9e913468c2a6dd1bd32be211d183f9735e0216b2d2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 17:18:26.675491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 17:18:26.675853) ========= 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.5lP0qmqTYQ/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.PbhUAA3gIy/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.005106 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 17:18:26.724883) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 17:18:26.725231) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 17:18:26.725566) ========= ========= Total master_lag: 0.18 =========