builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0002 starttime: 1475521051.1 results: success (0) buildid: 20161003095455 builduid: b65df51776d5488192ac48bdc4d7bdc5 revision: 6fe9b58ec2d9d626140950307d3b210798fc5e0b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.099409) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.099835) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.100190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.257394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.257678) ========= 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.nNPes4ejIH/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.ssgEbTPXOx/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-10-03 11:57:31-- 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% 8.61M=0.001s 2016-10-03 11:57:31 (8.61 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147439 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.439532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.439842) ========= 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.nNPes4ejIH/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.ssgEbTPXOx/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.021568 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.539341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:31.539649) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 6fe9b58ec2d9d626140950307d3b210798fc5e0b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 6fe9b58ec2d9d626140950307d3b210798fc5e0b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nNPes4ejIH/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.ssgEbTPXOx/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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-10-03 11:57:31,629 truncating revision to first 12 chars 2016-10-03 11:57:31,629 Setting DEBUG logging. 2016-10-03 11:57:31,629 attempt 1/10 2016-10-03 11:57:31,629 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/6fe9b58ec2d9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-03 11:57:32,308 unpacking tar archive at: larch-6fe9b58ec2d9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933840 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:32.514394) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:32.514678) ========= script_repo_revision: 6fe9b58ec2d9d626140950307d3b210798fc5e0b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:32.515074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:32.515359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-03 11:57:32.531782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-03 11:57:32.532067) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nNPes4ejIH/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.ssgEbTPXOx/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:57:32 INFO - MultiFileLogger online at 20161003 11:57:32 in /builds/slave/test 11:57:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 11:57:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:32 INFO - {'append_to_log': False, 11:57:32 INFO - 'base_work_dir': '/builds/slave/test', 11:57:32 INFO - 'blob_upload_branch': 'Larch', 11:57:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:32 INFO - 'branch': 'Larch', 11:57:32 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:32 INFO - 'config_files': ('talos/mac_config.py',), 11:57:32 INFO - 'default_actions': ('clobber', 11:57:32 INFO - 'read-buildbot-config', 11:57:32 INFO - 'download-and-extract', 11:57:32 INFO - 'populate-webroot', 11:57:32 INFO - 'create-virtualenv', 11:57:32 INFO - 'install', 11:57:32 INFO - 'run-tests'), 11:57:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:32 INFO - 'download_minidump_stackwalk': True, 11:57:32 INFO - 'download_symbols': 'ondemand', 11:57:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:57:32 INFO - 'tooltool.py': '/tools/tooltool.py', 11:57:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:57:32 INFO - '/tools/misc-python/virtualenv.py')}, 11:57:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:32 INFO - 'installer_path': 'installer.exe', 11:57:32 INFO - 'log_level': 'info', 11:57:32 INFO - 'log_name': 'talos', 11:57:32 INFO - 'log_to_console': True, 11:57:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:57:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:57:32 INFO - 'opt_config_files': (), 11:57:32 INFO - 'pip_index': False, 11:57:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:57:32 INFO - 'cmd': ('bash', 11:57:32 INFO - '-c', 11:57:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:57:32 INFO - 'enabled': True, 11:57:32 INFO - 'halt_on_failure': False, 11:57:32 INFO - 'name': 'check_screen_resolution'},), 11:57:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:57:32 INFO - 'cmd': ('bash', 11:57:32 INFO - '-c', 11:57:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:57:32 INFO - 'enabled': True, 11:57:32 INFO - 'halt_on_failure': False, 11:57:32 INFO - 'name': 'check_screen_resolution'},), 11:57:32 INFO - 'run_cmd_checks_enabled': True, 11:57:32 INFO - 'sps_profile': False, 11:57:32 INFO - 'sps_profile_interval': 0, 11:57:32 INFO - 'suite': 'dromaeojs-e10s', 11:57:32 INFO - 'system_bits': '32', 11:57:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:32 INFO - 'title': 't-yosemite-r7-0002', 11:57:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:32 INFO - 'use_talos_json': True, 11:57:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:32 INFO - 'work_dir': 'build'} 11:57:32 INFO - [mozharness: 2016-10-03 18:57:32.707365Z] Running clobber step. 11:57:32 INFO - Running pre-action listener: _resource_record_pre_action 11:57:32 INFO - Running main action method: clobber 11:57:32 INFO - rmtree: /builds/slave/test/build 11:57:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:34 INFO - Running post-action listener: _resource_record_post_action 11:57:34 INFO - [mozharness: 2016-10-03 18:57:34.242996Z] Finished clobber step (success) 11:57:34 INFO - [mozharness: 2016-10-03 18:57:34.243125Z] Running read-buildbot-config step. 11:57:34 INFO - Running pre-action listener: _resource_record_pre_action 11:57:34 INFO - Running main action method: read_buildbot_config 11:57:34 INFO - Using buildbot properties: 11:57:34 INFO - { 11:57:34 INFO - "project": "", 11:57:34 INFO - "product": "firefox", 11:57:34 INFO - "script_repo_revision": "production", 11:57:34 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 11:57:34 INFO - "repository": "", 11:57:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 11:57:34 INFO - "buildid": "20161003095455", 11:57:34 INFO - "pgo_build": "False", 11:57:34 INFO - "basedir": "/builds/slave/test", 11:57:34 INFO - "buildnumber": 0, 11:57:34 INFO - "slavename": "t-yosemite-r7-0002", 11:57:34 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 11:57:34 INFO - "platform": "yosemite_r7", 11:57:34 INFO - "scheduler": "tests-larch-macosx64-talos", 11:57:34 INFO - "branch": "larch", 11:57:34 INFO - "repo_path": "projects/larch", 11:57:34 INFO - "revision": "6fe9b58ec2d9d626140950307d3b210798fc5e0b", 11:57:34 INFO - "stage_platform": "macosx64", 11:57:34 INFO - "builduid": "b65df51776d5488192ac48bdc4d7bdc5", 11:57:34 INFO - "slavebuilddir": "test" 11:57:34 INFO - } 11:57:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 11:57:34 INFO - Running post-action listener: _resource_record_post_action 11:57:34 INFO - [mozharness: 2016-10-03 18:57:34.246419Z] Finished read-buildbot-config step (success) 11:57:34 INFO - [mozharness: 2016-10-03 18:57:34.246521Z] Running download-and-extract step. 11:57:34 INFO - Running pre-action listener: _resource_record_pre_action 11:57:34 INFO - Running main action method: download_and_extract 11:57:34 INFO - mkdir: /builds/slave/test/build/tests 11:57:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:34 INFO - trying https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 11:57:34 INFO - Downloading https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:57:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 11:57:34 INFO - Downloaded 1199 bytes. 11:57:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:57:34 INFO - Using the following test package requirements: 11:57:34 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:57:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 11:57:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 11:57:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'jsshell-mac.zip'], 11:57:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 11:57:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:57:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 11:57:34 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 11:57:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 11:57:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:57:34 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 11:57:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:57:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:57:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:57:34 INFO - Fetch https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:57:35 INFO - Expected file size: 16432494 11:57:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:57:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:57:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:57:43 INFO - Fetch https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:57:43 INFO - Expected file size: 16432494 11:57:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 11:57:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:57:50 INFO - Fetch https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 11:57:50 INFO - Expected file size: 14414059 11:57:52 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:57:52 INFO - trying https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:57:52 INFO - Downloading https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 11:57:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 11:57:55 INFO - Downloaded 111317617 bytes. 11:57:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:57:55 INFO - mkdir: /builds/slave/test/properties 11:57:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:57:55 INFO - Writing to file /builds/slave/test/properties/build_url 11:57:55 INFO - Contents: 11:57:55 INFO - build_url:https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:57:56 INFO - Running post-action listener: _resource_record_post_action 11:57:56 INFO - Running post-action listener: set_extra_try_arguments 11:57:56 INFO - [mozharness: 2016-10-03 18:57:56.288002Z] Finished download-and-extract step (success) 11:57:56 INFO - [mozharness: 2016-10-03 18:57:56.288120Z] Running populate-webroot step. 11:57:56 INFO - Running pre-action listener: _resource_record_pre_action 11:57:56 INFO - Running main action method: populate_webroot 11:57:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:57:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:57:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:57:56 INFO - '--tppagecycles', 11:57:56 INFO - '7'], 11:57:56 INFO - 'tests': ['tsvgm']}}, 11:57:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:57:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:57:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:57:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:57:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:57:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['damp', 'tps']}, 11:57:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'tests': ['damp', 'tps']}, 11:57:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['dromaeo_dom']}, 11:57:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:57:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['basic_compositor_video']}, 11:57:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:57:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['a11yr', 11:57:56 INFO - 'ts_paint', 11:57:56 INFO - 'tpaint', 11:57:56 INFO - 'sessionrestore', 11:57:56 INFO - 'sessionrestore_no_auto_restore', 11:57:56 INFO - 'tabpaint']}, 11:57:56 INFO - 'other-e10s': {'tests': ['a11yr', 11:57:56 INFO - 'ts_paint', 11:57:56 INFO - 'tpaint', 11:57:56 INFO - 'sessionrestore', 11:57:56 INFO - 'sessionrestore_no_auto_restore', 11:57:56 INFO - 'tabpaint']}, 11:57:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:57:56 INFO - 'ts_paint', 11:57:56 INFO - 'tpaint', 11:57:56 INFO - 'sessionrestore', 11:57:56 INFO - 'sessionrestore_no_auto_restore', 11:57:56 INFO - 'tabpaint']}, 11:57:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:57:56 INFO - 'ts_paint', 11:57:56 INFO - 'tpaint', 11:57:56 INFO - 'sessionrestore', 11:57:56 INFO - 'sessionrestore_no_auto_restore', 11:57:56 INFO - 'tabpaint']}, 11:57:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['a11yr', 11:57:56 INFO - 'ts_paint', 11:57:56 INFO - 'tpaint', 11:57:56 INFO - 'sessionrestore', 11:57:56 INFO - 'sessionrestore_no_auto_restore', 11:57:56 INFO - 'tabpaint']}, 11:57:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['a11yr', 11:57:56 INFO - 'ts_paint', 11:57:56 INFO - 'tpaint', 11:57:56 INFO - 'sessionrestore', 11:57:56 INFO - 'sessionrestore_no_auto_restore', 11:57:56 INFO - 'tabpaint']}, 11:57:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['tsvgx', 11:57:56 INFO - 'tsvgr_opacity', 11:57:56 INFO - 'tart', 11:57:56 INFO - 'tscrollx', 11:57:56 INFO - 'cart']}, 11:57:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:57:56 INFO - 'tsvgr_opacity', 11:57:56 INFO - 'tart', 11:57:56 INFO - 'tscrollx', 11:57:56 INFO - 'cart']}, 11:57:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'talos_options': ['--disable-e10s'], 11:57:56 INFO - 'tests': ['tp5o']}, 11:57:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'tests': ['tp5o']}, 11:57:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'talos_options': ['--disable-e10s', 11:57:56 INFO - '--xperf_path', 11:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:56 INFO - 'tests': ['tp5n']}, 11:57:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:57:56 INFO - 'talos_options': ['--xperf_path', 11:57:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:57:56 INFO - 'tests': ['tp5n']}}, 11:57:56 INFO - 'talos.zip': {'path': '', 11:57:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:57:56 INFO - Running post-action listener: _resource_record_post_action 11:57:56 INFO - [mozharness: 2016-10-03 18:57:56.306828Z] Finished populate-webroot step (success) 11:57:56 INFO - [mozharness: 2016-10-03 18:57:56.306965Z] Running create-virtualenv step. 11:57:56 INFO - Running pre-action listener: _resource_record_pre_action 11:57:56 INFO - Running main action method: create_virtualenv 11:57:56 INFO - Creating virtualenv /builds/slave/test/build/venv 11:57:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:57:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:57:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:57:56 INFO - Using real prefix '/tools/python27' 11:57:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:57:57 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:00 INFO - Installing pip.................done. 11:58:00 INFO - Return code: 0 11:58:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:00 INFO - 'HOME': '/Users/cltbld', 11:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:00 INFO - 'LOGNAME': 'cltbld', 11:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:00 INFO - 'MOZ_NO_REMOTE': '1', 11:58:00 INFO - 'NO_EM_RESTART': '1', 11:58:00 INFO - 'PAGER': '/bin/cat', 11:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:00 INFO - 'PWD': '/builds/slave/test', 11:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:00 INFO - 'SHELL': '/bin/bash', 11:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:00 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:00 INFO - 'USER': 'cltbld', 11:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:00 INFO - 'XPC_FLAGS': '0x0', 11:58:00 INFO - 'XPC_SERVICE_NAME': '0', 11:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:58:00 INFO - Cleaning up... 11:58:00 INFO - Return code: 0 11:58:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:58:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:58:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:00 INFO - 'HOME': '/Users/cltbld', 11:58:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:00 INFO - 'LOGNAME': 'cltbld', 11:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:00 INFO - 'MOZ_NO_REMOTE': '1', 11:58:00 INFO - 'NO_EM_RESTART': '1', 11:58:00 INFO - 'PAGER': '/bin/cat', 11:58:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:00 INFO - 'PWD': '/builds/slave/test', 11:58:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:00 INFO - 'SHELL': '/bin/bash', 11:58:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:00 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:00 INFO - 'USER': 'cltbld', 11:58:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:00 INFO - 'XPC_FLAGS': '0x0', 11:58:00 INFO - 'XPC_SERVICE_NAME': '0', 11:58:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:00 INFO - Downloading/unpacking psutil>=3.1.1 11: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 11: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 11: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 11: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 11: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 11: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 11:58:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:04 INFO - Installing collected packages: psutil 11:58:04 INFO - Running setup.py install for psutil 11:58:04 INFO - building 'psutil._psutil_osx' extension 11:58:04 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 11:58:04 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 11:58:04 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 11:58:04 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 11:58:04 INFO - building 'psutil._psutil_posix' extension 11:58:04 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 11:58:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:58:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:58:04 INFO - ^ 11:58:05 INFO - 1 warning generated. 11:58:05 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 11:58:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:05 INFO - Successfully installed psutil 11:58:05 INFO - Cleaning up... 11:58:05 INFO - Return code: 0 11:58:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:58:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:05 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:05 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 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:05 INFO - 'HOME': '/Users/cltbld', 11:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:05 INFO - 'LOGNAME': 'cltbld', 11:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:05 INFO - 'MOZ_NO_REMOTE': '1', 11:58:05 INFO - 'NO_EM_RESTART': '1', 11:58:05 INFO - 'PAGER': '/bin/cat', 11:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:05 INFO - 'PWD': '/builds/slave/test', 11:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:05 INFO - 'SHELL': '/bin/bash', 11:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:05 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:05 INFO - 'USER': 'cltbld', 11:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:05 INFO - 'XPC_FLAGS': '0x0', 11:58:05 INFO - 'XPC_SERVICE_NAME': '0', 11:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:58:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:58:08 INFO - Installing collected packages: mozsystemmonitor 11:58:08 INFO - Running setup.py install for mozsystemmonitor 11:58:08 INFO - Successfully installed mozsystemmonitor 11:58:08 INFO - Cleaning up... 11:58:08 INFO - Return code: 0 11:58:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:58:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:58:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:08 INFO - 'HOME': '/Users/cltbld', 11:58:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:08 INFO - 'LOGNAME': 'cltbld', 11:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:08 INFO - 'MOZ_NO_REMOTE': '1', 11:58:08 INFO - 'NO_EM_RESTART': '1', 11:58:08 INFO - 'PAGER': '/bin/cat', 11:58:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:08 INFO - 'PWD': '/builds/slave/test', 11:58:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:08 INFO - 'SHELL': '/bin/bash', 11:58:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:08 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:08 INFO - 'USER': 'cltbld', 11:58:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:08 INFO - 'XPC_FLAGS': '0x0', 11:58:08 INFO - 'XPC_SERVICE_NAME': '0', 11:58:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:08 INFO - Downloading/unpacking jsonschema==2.5.1 11: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 11: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 11: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 11: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 11: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 11: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 11:58:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:11 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:11 INFO - warning: no files found matching '*.txt' 11:58:11 INFO - no previously-included directories found matching 'build' 11:58:11 INFO - no previously-included directories found matching 'dist' 11:58:11 INFO - no previously-included directories found matching '.git*' 11:58:11 INFO - Installing collected packages: jsonschema, functools32 11:58:11 INFO - Running setup.py install for functools32 11:58:11 INFO - warning: no files found matching '*.txt' 11:58:11 INFO - no previously-included directories found matching 'build' 11:58:11 INFO - no previously-included directories found matching 'dist' 11:58:11 INFO - no previously-included directories found matching '.git*' 11:58:11 INFO - Successfully installed jsonschema functools32 11:58:11 INFO - Cleaning up... 11:58:11 INFO - Return code: 0 11:58:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11: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 functools32==3.2.3-2 11:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:11 INFO - 'HOME': '/Users/cltbld', 11:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:11 INFO - 'LOGNAME': 'cltbld', 11:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:11 INFO - 'MOZ_NO_REMOTE': '1', 11:58:11 INFO - 'NO_EM_RESTART': '1', 11:58:11 INFO - 'PAGER': '/bin/cat', 11:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:11 INFO - 'PWD': '/builds/slave/test', 11:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:11 INFO - 'SHELL': '/bin/bash', 11:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:11 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:11 INFO - 'USER': 'cltbld', 11:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:11 INFO - 'XPC_FLAGS': '0x0', 11:58:11 INFO - 'XPC_SERVICE_NAME': '0', 11:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:58:12 INFO - Cleaning up... 11:58:12 INFO - Return code: 0 11:58:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:12 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 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:58:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:12 INFO - 'HOME': '/Users/cltbld', 11:58:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:12 INFO - 'LOGNAME': 'cltbld', 11:58:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:12 INFO - 'MOZ_NO_REMOTE': '1', 11:58:12 INFO - 'NO_EM_RESTART': '1', 11:58:12 INFO - 'PAGER': '/bin/cat', 11:58:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:12 INFO - 'PWD': '/builds/slave/test', 11:58:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:12 INFO - 'SHELL': '/bin/bash', 11:58:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:12 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:12 INFO - 'USER': 'cltbld', 11:58:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:12 INFO - 'XPC_FLAGS': '0x0', 11:58:12 INFO - 'XPC_SERVICE_NAME': '0', 11:58:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:12 INFO - Downloading/unpacking blobuploader==1.2.4 11:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:14 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:15 INFO - Downloading docopt-0.6.1.tar.gz 11:58:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:16 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:16 INFO - Running setup.py install for blobuploader 11:58:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:16 INFO - Running setup.py install for requests 11:58:16 INFO - Running setup.py install for docopt 11:58:16 INFO - Successfully installed blobuploader requests docopt 11:58:16 INFO - Cleaning up... 11:58:16 INFO - Return code: 0 11:58:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:16 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 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:58:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:58:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:16 INFO - 'HOME': '/Users/cltbld', 11:58:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:16 INFO - 'LOGNAME': 'cltbld', 11:58:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:16 INFO - 'MOZ_NO_REMOTE': '1', 11:58:16 INFO - 'NO_EM_RESTART': '1', 11:58:16 INFO - 'PAGER': '/bin/cat', 11:58:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:16 INFO - 'PWD': '/builds/slave/test', 11:58:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:16 INFO - 'SHELL': '/bin/bash', 11:58:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:16 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:16 INFO - 'USER': 'cltbld', 11:58:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:16 INFO - 'XPC_FLAGS': '0x0', 11:58:16 INFO - 'XPC_SERVICE_NAME': '0', 11:58:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wsIAmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vfxMRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UQ9YOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CFrBWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-s_kN0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-pXUWAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-U51P32-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:17 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Hbdpka-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-jjOTs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-t6sMcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-M8ZPJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-3xd9xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-q3CbFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-sK1YPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-cqkA9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-LlzdNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:18 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-cNFvGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:18 INFO - Running setup.py install for manifestparser 11:58:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:19 INFO - Running setup.py install for mozcrash 11:58:19 INFO - Running setup.py install for mozdebug 11:58:19 INFO - Running setup.py install for mozdevice 11:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:19 INFO - Running setup.py install for mozfile 11:58:19 INFO - Running setup.py install for mozhttpd 11:58:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:19 INFO - Running setup.py install for mozinfo 11:58:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:19 INFO - Running setup.py install for mozInstall 11:58:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Running setup.py install for mozleak 11:58:20 INFO - Running setup.py install for mozlog 11:58:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Running setup.py install for moznetwork 11:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Running setup.py install for mozprocess 11:58:20 INFO - Running setup.py install for mozprofile 11:58:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:20 INFO - Running setup.py install for mozrunner 11:58:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:21 INFO - Running setup.py install for mozscreenshot 11:58:21 INFO - Running setup.py install for moztest 11:58:21 INFO - Running setup.py install for mozversion 11:58:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:21 INFO - Cleaning up... 11:58:21 INFO - Return code: 0 11:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:21 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 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:21 INFO - 'HOME': '/Users/cltbld', 11:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:21 INFO - 'LOGNAME': 'cltbld', 11:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:21 INFO - 'MOZ_NO_REMOTE': '1', 11:58:21 INFO - 'NO_EM_RESTART': '1', 11:58:21 INFO - 'PAGER': '/bin/cat', 11:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:21 INFO - 'PWD': '/builds/slave/test', 11:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:21 INFO - 'SHELL': '/bin/bash', 11:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:21 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:21 INFO - 'USER': 'cltbld', 11:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:21 INFO - 'XPC_FLAGS': '0x0', 11:58:21 INFO - 'XPC_SERVICE_NAME': '0', 11:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-yCFsQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:21 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Yz0qiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-MrIVKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-tJ6hN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wozS6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-axxSBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-OrrmKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Z_vYm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rI0Z17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-EhJjEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:22 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-EbiTBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-vsH3ko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-HHzgh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XdTQXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-URJSoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-DTVA88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:58:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:23 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-biFZGj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:58:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:26 INFO - Downloading blessings-1.6.tar.gz 11:58:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:26 INFO - Installing collected packages: blessings 11:58:26 INFO - Running setup.py install for blessings 11:58:26 INFO - Successfully installed blessings 11:58:26 INFO - Cleaning up... 11:58:26 INFO - Return code: 0 11:58:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:26 INFO - Reading from file tmpfile_stdout 11:58:26 INFO - Current package versions: 11:58:26 INFO - blessings == 1.6 11:58:26 INFO - blobuploader == 1.2.4 11:58:26 INFO - docopt == 0.6.1 11:58:26 INFO - functools32 == 3.2.3-2 11:58:26 INFO - jsonschema == 2.5.1 11:58:26 INFO - manifestparser == 1.1 11:58:26 INFO - mozInstall == 1.12 11:58:26 INFO - mozcrash == 0.17 11:58:26 INFO - mozdebug == 0.1 11:58:26 INFO - mozdevice == 0.48 11:58:26 INFO - mozfile == 1.2 11:58:26 INFO - mozhttpd == 0.7 11:58:26 INFO - mozinfo == 0.9 11:58:26 INFO - mozleak == 0.1 11:58:26 INFO - mozlog == 3.4 11:58:26 INFO - moznetwork == 0.27 11:58:26 INFO - mozprocess == 0.23 11:58:26 INFO - mozprofile == 0.28 11:58:26 INFO - mozrunner == 6.12 11:58:26 INFO - mozscreenshot == 0.1 11:58:26 INFO - mozsystemmonitor == 0.3 11:58:26 INFO - moztest == 0.7 11:58:26 INFO - mozversion == 1.4 11:58:26 INFO - psutil == 3.1.1 11:58:26 INFO - requests == 1.2.3 11:58:26 INFO - wsgiref == 0.1.2 11:58:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:26 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 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:26 INFO - 'HOME': '/Users/cltbld', 11:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:26 INFO - 'LOGNAME': 'cltbld', 11:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:26 INFO - 'MOZ_NO_REMOTE': '1', 11:58:26 INFO - 'NO_EM_RESTART': '1', 11:58:26 INFO - 'PAGER': '/bin/cat', 11:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:26 INFO - 'PWD': '/builds/slave/test', 11:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:26 INFO - 'SHELL': '/bin/bash', 11:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:26 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:26 INFO - 'USER': 'cltbld', 11:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:26 INFO - 'XPC_FLAGS': '0x0', 11:58:26 INFO - 'XPC_SERVICE_NAME': '0', 11:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:58:27 INFO - Cleaning up... 11:58:27 INFO - Return code: 0 11:58:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:58:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101851490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1017c7570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc86ace5c20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, '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.nNPes4ejIH/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.ssgEbTPXOx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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 11:58:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:58:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:58:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:58:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:58:27 INFO - 'HOME': '/Users/cltbld', 11:58:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:58:27 INFO - 'LOGNAME': 'cltbld', 11:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:27 INFO - 'MOZ_NO_REMOTE': '1', 11:58:27 INFO - 'NO_EM_RESTART': '1', 11:58:27 INFO - 'PAGER': '/bin/cat', 11:58:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:27 INFO - 'PWD': '/builds/slave/test', 11:58:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:58:27 INFO - 'SHELL': '/bin/bash', 11:58:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:58:27 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:58:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:58:27 INFO - 'USER': 'cltbld', 11:58:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:58:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:27 INFO - 'XPC_FLAGS': '0x0', 11:58:27 INFO - 'XPC_SERVICE_NAME': '0', 11:58:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:27 INFO - Cleaning up... 11:58:27 INFO - Return code: 0 11:58:27 INFO - Running post-action listener: _resource_record_post_action 11:58:27 INFO - Running post-action listener: _start_resource_monitoring 11:58:27 INFO - Starting resource monitoring. 11:58:27 INFO - [mozharness: 2016-10-03 18:58:27.335957Z] Finished create-virtualenv step (success) 11:58:27 INFO - [mozharness: 2016-10-03 18:58:27.336920Z] Running install step. 11:58:27 INFO - Running pre-action listener: _resource_record_pre_action 11:58:27 INFO - Running main action method: install 11:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:27 INFO - Reading from file tmpfile_stdout 11:58:27 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:27 INFO - Reading from file tmpfile_stdout 11:58:27 INFO - Output received: 11:58:27 INFO - Usage: mozinstall [options] installer 11:58:27 INFO - Options: 11:58:27 INFO - -h, --help show this help message and exit 11:58:27 INFO - -d DEST, --destination=DEST 11:58:27 INFO - Directory to install application into. [default: 11:58:27 INFO - "/builds/slave/test"] 11:58:27 INFO - --app=APP Application being installed. [default: firefox] 11:58:27 INFO - mkdir: /builds/slave/test/build/application 11:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:59:02 INFO - Reading from file tmpfile_stdout 11:59:02 INFO - Output received: 11:59:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:59:02 INFO - Running post-action listener: _resource_record_post_action 11:59:02 INFO - [mozharness: 2016-10-03 18:59:02.094869Z] Finished install step (success) 11:59:02 INFO - [mozharness: 2016-10-03 18:59:02.095024Z] Running run-tests step. 11:59:02 INFO - Running pre-action listener: _resource_record_pre_action 11:59:02 INFO - Running main action method: run_tests 11:59:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:59:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:59:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:59:02 INFO - 2016-10-03 11:59:02.109 screenresolution[1933:17417] starting screenresolution argv=screenresolution get 11:59:02 INFO - 2016-10-03 11:59:02.112 screenresolution[1933:17417] Display 0: 1600x1200x32@60 11:59:02 INFO - 2016-10-03 11:59:02.118 screenresolution[1934:17420] starting screenresolution argv=screenresolution list 11:59:02 INFO - Available Modes on Display 0 11:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:59:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:59:02 INFO - Intel Iris: 11:59:02 INFO - Chipset Model: Intel Iris 11:59:02 INFO - Type: GPU 11:59:02 INFO - Bus: Built-In 11:59:02 INFO - VRAM (Dynamic, Max): 1536 MB 11:59:02 INFO - Vendor: Intel (0x8086) 11:59:02 INFO - Device ID: 0x0a2e 11:59:02 INFO - Revision ID: 0x0009 11:59:02 INFO - Displays: 11:59:02 INFO - Display: 11:59:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:59:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:59:02 INFO - Display Serial Number: 1600x1200 60 11:59:02 INFO - Main Display: Yes 11:59:02 INFO - Mirror: Off 11:59:02 INFO - Online: Yes 11:59:02 INFO - Rotation: Supported 11:59:02 INFO - Return code: 0 11:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:02 INFO - Python 2.7.3 11:59:02 INFO - Return code: 0 11:59:02 INFO - grabbing minidump binary from tooltool 11:59:02 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:59:02 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 0x101665d30>, '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 0x10148bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10165db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59:02 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 11:59:02 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 11:59:02 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 11:59:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:02 INFO - Return code: 0 11:59:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:59:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:59:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 11:59:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --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 11:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nNPes4ejIH/Render', 11:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:59:02 INFO - 'HOME': '/Users/cltbld', 11:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:59:02 INFO - 'LOGNAME': 'cltbld', 11:59:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:02 INFO - 'MOZ_NO_REMOTE': '1', 11:59:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:02 INFO - 'NO_EM_RESTART': '1', 11:59:02 INFO - 'PAGER': '/bin/cat', 11:59:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:02 INFO - 'PWD': '/builds/slave/test', 11:59:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:59:02 INFO - 'SHELL': '/bin/bash', 11:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ssgEbTPXOx/Listeners', 11:59:02 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 11:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:59:02 INFO - 'USER': 'cltbld', 11:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:02 INFO - 'XPC_FLAGS': '0x0', 11:59:02 INFO - 'XPC_SERVICE_NAME': '0', 11:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:59:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--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 11:59:02 INFO - mozversion application_buildid: 20161003095455 11:59:02 INFO - mozversion application_changeset: 6fe9b58ec2d9d626140950307d3b210798fc5e0b 11:59:02 INFO - mozversion application_display_name: Nightly 11:59:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:02 INFO - mozversion application_name: Firefox 11:59:02 INFO - mozversion application_remotingname: firefox 11:59:02 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 11:59:02 INFO - mozversion application_vendor: Mozilla 11:59:02 INFO - mozversion application_version: 52.0a1 11:59:02 INFO - mozversion platform_buildid: 20161003095455 11:59:02 INFO - mozversion platform_changeset: 6fe9b58ec2d9d626140950307d3b210798fc5e0b 11:59:02 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 11:59:02 INFO - mozversion platform_version: 52.0a1 11:59:02 INFO - using testdate: 1475521142 11:59:02 INFO - actual date: 1475521142 11:59:02 INFO - starting webserver on 'localhost:52722' 11:59:02 INFO - SUITE-START | Running 2 tests 11:59:02 INFO - TEST-START | dromaeo_css 11:59:02 INFO - operating with platform_type : mac_ 11:59:02 INFO - Initialising browser for dromaeo_css test... 11:59:02 INFO - TEST-INFO | started process 1944 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmprLVh_p/profile http://localhost:52722/getInfo.html) 11:59:05 INFO - PROCESS | 1944 | __metrics Screen width/height:1600/1200 11:59:05 INFO - PROCESS | 1944 | colorDepth:24 11:59:05 INFO - PROCESS | 1944 | Browser inner width/height: 1024/689 11:59:05 INFO - PROCESS | 1944 | __metrics 11:59:05 ERROR - PROCESS | 1944 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 11:59:06 INFO - TEST-INFO | 1944: exit 0 11:59:06 INFO - Browser initialized. 11:59:06 INFO - Running cycle 1/1 for dromaeo_css test... 11:59:06 INFO - TEST-INFO | started process 1947 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmprLVh_p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:18 INFO - PROCESS | 1947 | RSS: Main: 244129792 11:59:18 INFO - PROCESS | 1947 | 12:00:07 INFO - PROCESS | 1947 | 1475521207949 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:02:19 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52722/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52722/tests/dromaeo/cssquery-ext.html) 12:02:21 INFO - PROCESS | 1947 | RSS: Main: 257667072 12:02:21 INFO - PROCESS | 1947 | 12:05:23 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52722/tests/dromaeo/cssquery-ext.html (next: http://localhost:52722/tests/dromaeo/cssquery-jquery.html) 12:05:24 INFO - PROCESS | 1947 | RSS: Main: 268406784 12:05:24 INFO - PROCESS | 1947 | 12:08:26 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52722/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52722/tests/dromaeo/cssquery-mootools.html) 12:08:26 INFO - PROCESS | 1947 | RSS: Main: 273022976 12:08:26 INFO - PROCESS | 1947 | 12:11:28 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52722/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52722/tests/dromaeo/cssquery-prototype.html) 12:11:29 INFO - PROCESS | 1947 | RSS: Main: 273575936 12:11:29 INFO - PROCESS | 1947 | 12:14:32 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52722/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52722/tests/dromaeo/cssquery-yui.html) 12:14:32 INFO - PROCESS | 1947 | RSS: Main: 278941696 12:14:32 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | Cycle 1(1): loaded http://localhost:52722/tests/dromaeo/cssquery-yui.html (next: http://localhost:52722/tests/dromaeo/cssquery-dojo.html) 12:17:35 INFO - PROCESS | 1947 | RSS: Main: 281702400 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | __start_tp_report 12:17:35 INFO - PROCESS | 1947 | _x_x_mozilla_page_load 12:17:35 INFO - PROCESS | 1947 | _x_x_mozilla_page_load_details 12:17:35 INFO - PROCESS | 1947 | |i|pagename|runs| 12:17:35 INFO - PROCESS | 1947 | |0;dojo.html;3350.977951724723;3372;3389.9830050984697;3396.728261739061;3402.1494626343406;5627.212190293352;5699.68651724155;5739.512141467975;5745.224394706714;5783.5373170146395;5643.5767317451255;5740.569457290699;5760.913586296198;5838.328592211897;5848.2689663792025;5169.870753231162;5178.456262092483;5266.605004624668;5299.655522391052;5346.117890548055;5315.840524784263;5343.038253114438;5369.973150134244;5375.381831089436;5412.91880621791;3827.445020472016;5133.717645529495;5178.223266510016;5187.170052791555;5223.085959956992;5205.791768329263;5223.4776522347465;5225.634205605609;5254.973725131388;5290.365156181283;4240.38514415408;5192.273081768555;5210.218467229908;5222.399424066205;5241.475852414728;5239.633225674204;5411.404745477994;5649.406812284692;5651.632643878134;5719.828405147852;6200.348963358872;6235.937640623626;6237.157983672191;6250.749970001195;6258;6290.150829637986;6293.339199384044;6297.149884765589;6306.621602703853;6314.179156709644;5618.634788738719;5646.378898321182;5732.570057245724;5834.095715164156;5861.531077513831;6153.476954458832;6230.252369715663;6247.250329960343;6254.499640028877;6264.091706702503;5921.792737254175;5929.555283353766;5993.130996005642;6021.458068773832;6065.059915713072;6096.829073522031;6150.231221097363;6159.907601385983;6171.444569988723;6179.196704428396;5342.2787923630585;6212.285587157445;6230.626162430269;6239.594426362272;6249.125122482856;6195.845103872349;6212.347703491158;6227.719752611143;6231.22109736283;6253.468455181361;4853.733044682576;4908.3619129513645;4912.091263116335;4935.777889994959;4952.281919121707;3533.434650455915;3701.833417496165;3712.9232522568154;3740.869069582606;4316.223079845658;5432.266644003009;5694.402087780723;5742.339630942495;5776.855578610568;5780.624259423124;6103.6948152592195;6127.494965205055;6212.223472065992;6243.937560624427;6256.655883926428;5781.8554536136935;5792.218050563204;5839.532837373;5865.178874957509;5926.555508336892;4447.844325448594;4472.44094488189;5362.222477740784;5387.9770036260425;5393.083175860113;6149.292831324455;6313.968430157912;6336.52476064297;6345;6366.618002919747;5393.487618676219;6118.418750218722;6203.193584833943;6247.156633854554;6256.343083976117;6307.24313082433;6313.242410910537;6327.272363678236;6328.082428047999;6333.461655759312;6089.33017368098;6090.636117690217;6148.815535533941;6181.072839074175;6195.628262304276;6216.906746398898;6256.687165641791;6264.686765661608;6281.842953926189;6299.401556852092;6161.753529858755;6177.567570270038;6184.845378865564;6200.81397558074;6207.689615519296;5022.447530771686;6117.357677443804;6157.753689852535;6164.630122192682;6165.260168779775;5005.624578156726;5907.852303692442;5955.136505206808;6004.159417681441;6130;5744.684042377709;6149.661768602769;6158.384161583985;6159.043659043595;6214.9067763982675;6036.879262414639;6077.20996270482;6083.057126145454;6091.208142941389;6097.603655762361 12:17:35 INFO - PROCESS | 1947 | |1;ext.html;455.5308032726293;462.5813638657016;483.87177397989564;510.9933431140654;537.414218501833;38713.03217419562;40371.99070023247;40413.19173616526;42835.78582107085;42891.35662965058;41940.79029604848;42365;42441.787791061004;42489.838973348844;42541;8578.270846978014;9798.069183427562;9801.803963920718;9825.361351512129;9858.359206651581;9669.081437263449;9804.509774511282;9811.313208075437;9829.67299414577;9843.212542996544;8397.748067557952;9828;9832.016798320146;9837.262205334593;9869.851952220723;9752.707418777483;9761.951190244039;9789.265805064648;9791.314607977445;9824.312298139133;9607.711768646952;9701.223902087817;9712.902870971271;9720.368176068603;9723.076307750753;40028.99927501807;40258.39612405816;40458.98852528681;40474.39288410676;40490.59509404898;3381.3575420669995;3392.3215356928713;3417.3507033663773;3425.1950791563963;3684.613115622875;21731.891340543356;23774;24751.381215469577;25324;29713.55429668535;2556.401480757136;3234.433974054531;3255.088575198948;3299.406106900757;3355.446351352024;379707;501933;503380;503650;504748.47625761636;55535.444645553835;55712.85742851446;55838;55901.161482577794;55920.16119758207;34610.48084278738;34674.653253467644;34732;35384;35424.645753542136;16302;16303.510894673178;16494.42269520561;16510.504684859472;16549.751753723704;12374.690632734073;12690.746185076247;12773.936130319289;12784.105112642026;12803.03977201695;18331.725024124647;18428.170732317078;18482.168302426155;18494.352697655788;18579.32786049262;7771.533707977426;7898.249666281694;7910.5649189295145;7941.404394670423;7956.482828616237;832.6045128564004;906.2749800159977;946.7159852044359;949.4113649537331;1065.9786804263872;27578.89684412601;29611.25971850678;29727.10818675443;30854.38291234163;31003.844980775404;967.0957654592978;1034.99482502587;1069.8876617955002;1076.4187338837096;1124.6344937895217;15500.457483988006;15575.844241557666;15607.609809754847;15613.609659758597;15804.209789510709;643770;647740;648100;648971;650157;55056;56099.439005610235;56111.87776244452;56264;56265.71867140638;1317.6903427694483;1337.2110454831502;1352.513095285716;1355.349432272495;1362.754704153242;27127.050553230543;28451.857740711162;29559.113226603236;30270.243243919078;30297.545536817408;43736.56263437325;44157.55842441534;44302.55697442984;44365.77817110894;44589.777051114535;590516;590807;592103;592566;592844;23974.160904368262;24013;24225.63661545043;24228.394290142183;24252.75747242505;37580.43629345507;45364;45644.54355456403;46833.531664682916;47295.29057064216;38233;38571.614283856805;39180;39188.41217381799;39296;31114.844425777726;37622;37929.4310585347;38261;38381.80809095937;29068.854655726587;37773.62226377701;37872.86381408562;37983;38372.42441363438;31843;33647.99056028323;33772.662273376955;34276.48585271273;34376.656233437345;25279.87360063188;25446.872765636053;25621.05599488804;25703;25820.35449113787 12:17:35 INFO - PROCESS | 1947 | |2;jquery.html;314.40106596932844;378.1718037497878;387.73246459942635;391.7590681730737;411.3911411111555;18986.62026759464;19090.61624996902;20073.498162545944;20115.899420502894;20277.188912443522;20028.499287517818;20240.493987650316;20296.28962986292;20444.386668399933;20846.791532084673;5239.397469291023;5658.7170641467965;5853.76584936602;5929.051351783715;6485.286618471964;6564.7045882935145;6643.833904152387;6645.867082658344;6660.167479065117;6666.333366663343;5343.919841202385;5458.808941687042;5589.916151257735;5592.412796656354;5931.673757943311;4825.517448255181;4902.509749025105;5814.011618024946;5953.970230148843;5957.31490878548;4762.357081793983;5677.432256774289;5686.260786097822;5714.657120572738;5731.340895796953;12566.434510446961;12786.360681965865;16205.837941620552;25229.87385063063;25528.744712552823;2225.5326381459913;2241.148363621813;2264.30938563738;2669.626252324676;2981.6272965879266;9568.425894446356;9829;9849.064338887794;10104.141148002429;10409.115225205867;1793.9192736326897;1813.4313818546862;1879.9248030078782;1891.5743957609566;1950.1906708715867;121809;125053.37473312575;131819.02271465937;136938.6306136936;137461;9990.851052128954;10731.517081731341;10941.398223097805;11094.55621775136;11202.775944481227;12721.173123746927;13946.511872084631;13957.58127256184;13994.930025350011;14005.229712365917;8342.37432192588;8516.8722469163;8535.914640853513;8607.698730544402;8654.567271636393;7661.46369754123;8470.915290847013;8552.230299273095;8559.186877246651;8683.869741953877;4351.73889566627;4427.845025424094;4434.600885920283;4493.775311234425;4542.409486766699;1490.1431676785892;1715.3738885307023;1793.2378739035858;1861.897595632226;1920.8847469151895;723.869703453373;843.409613270713;849.7790574450687;876.4565969099199;960.7646126698863;19502.609947801247;20199.899000505196;20363.389098327072;20367.796322036887;20600.175992960114;859.9484030958163;885.4333226734894;918.9264858811279;956.6316967967383;963.8602402651576;10452.843207351896;10870.836937445945;10886.346819190874;10892.40091794943;10955.671329860117;589505;600345;601381;610779;614143;123689;132930.33534832264;134565;136353;138574.6142538582;1031.097789434245;1037.6731329631143;1044.7283706236433;1097.4512743628186;1099.4997276239292;18554.44336669902;19149.712754308417;19283.90358048257;19394.612107757483;19429.61140777148;38809.41785873158;52710;54293.185602216785;55696.72151639216;56948.291551253526;83738.74391884249;83867;84240.57879710807;84414.57792710997;85435;7855.5286682799215;7943.682252709827;7987.84024319522;8130.593470326342;8227.465214761021;10392.804827444941;11276.436178191221;11731.706707332043;11772.293662380285;12003.219790713576;9981.650642227487;10202.438865862448;10860.67417977462;11131.664200296016;11157.10743140563;10817.1346292298;10881.292715973437;10967.477480179445;11230.83153752678;11307.886921131012;10372.325798823053;10968.616098436516;11047.226694131334;11086.889131108908;11192.608258710907;7788.649510771916;7872.84254314922;7947.9732668171555;8169.5098294102545;8204.056533498724;10391.480425978822;10721.30311529748;10816.08063314627;11025.558977640805;11265.943670281596 12:17:35 INFO - PROCESS | 1947 | |3;mootools.html;1298.415712929182;1372.8352597688279;1440.933709055299;1836.7704036995376;1867.4117652939315;7942.523448593089;8030.116687164407;8211.63047662855;8320.33437325014;9033.457992520453;8445.746627601166;8751.649934002633;8770;8891.955540222307;8911.91088089119;2399.196269249803;2424.127314166907;2431.258466167818;2436.8294219404647;2455.3493324269084;2025.8885761283123;2414.468816860288;2436.013414567103;2453.50929814037;2453.9938625163686;2416.250962201714;2423.6243382275775;2431.817613678981;2448.436859522311;2451.656768052474;2374.27584586701;2384.1893756122913;2391.6173412253956;2396.940076498084;2433.0632706407982;2397.8920948557356;2414.7826695597305;2418.262429958862;2428.5871401861727;2432.987835060831;7479.32686058252;7497.550146991198;8867.512286824222;8945.46327220369;8970.147835955639;5259.5529380002745;5412.134058550652;5413.160960051159;5418.2685337479725;5441.020616289066;3178.2054486378406;3452.154222215548;3694.538182727159;3752.418375151856;3754.3805272130066;1073.259450978822;1112.5494174859195;1118.2507719827736;1132.9263597866113;1133.5012594458412;11753.4710938008;11827.112966527546;11856.22934509254;11878.703032424171;11896.22674526153;4528.6150677192145;4697.13103075932;4840.00779840132;4870.805167793249;4896.2655601660035;8264.421490495728;9895.851562226573;9979.10188083076;9980.700578982642;10003.499825008721;5376.1129413647095;5401.756920938488;5425.972870135624;5437.537809286176;5441.455854414527;4424.203643344229;4575.473820510684;4771.045790841846;4923.679960802537;4974.801007959713;3935.193285376491;3969.940450893239;4048.473698419187;4073.857414990461;4076.673866090765;1330.6141219046563;1344.5159742492694;1348.5347555093476;1359.7076628524915;1363.3592211660505;742.046470285691;833.5207255827924;906.9501177435304;914.6570036236411;944.5843828715343;5724.8282551523525;5796.94203057964;5929.673867937305;5960.493358064613;6056.727447264883;892;921.760342311004;940.8965013848472;962.2494454325637;988.2341185581232;3915.569287378386;3936.4882565266903;3999.6004395165087;4030.2141082488633;4030.879073627796;10580.629677961235;10824.458777061272;10930.672079837459;10940.179486538542;10973.3964631946;10856.78286434267;10857.891421085846;10874.347539147677;10898.166476716111;10904.400257985728;7685.269899359552;8036.517808931483;8057.106579953824;8159.796005099801;8172.6322315495945;5882.705864706833;5886.85206384768;5947.167396564398;6081.695915204134;6185.84535386619;9941.850872237066;10204.183665306906;10221.795564088528;10245.795084098127;10249.74375640615;9926;10041.648542300984;10170.033846784543;10420.166386689198;10495.370277783357;6956.5478243913985;7146.535475194096;7397.741079062207;7473.51422157558;7679.692812287446;6527.5430719849155;6934.271901450476;7347.5224110432655;8298.917010830057;8358.70744523963;7395.7041718330665;7500.624968751432;7508.549487030796;7561.924380756122;7638.1216160140075;7089.184743754534;7226.89159662616;7281.745138920112;7304.7078116876855;7396.112466503839;6884.208316043719;6912.965435172792;6977.860442791217;6993.475489338218;6999;4330.9133817322845;4788.066327066189;4839.491853355347;4933.186024305949;4938.43208031081;4932.556069953722;4960.900781984412;5000.799968001239;5042.042012017705;5058.772355243949 12:17:35 INFO - PROCESS | 1947 | |4;prototype.html;264.9920502384929;280.2461378890785;315.4038866542236;316.863748588107;317.9300553878146;4656.371389862367;4818.229083346665;5101.489851014897;5112.140334047789;5690.004249256379;4346.456692913386;4861.7812198451065;5486.43381801828;5507.5593952483805;5568.3596386415575;4237.851675191377;4252.7029256076885;4263.252066652673;4273.252180868351;4282.957170428287;3850;3904.5509766376945;3907;4087.61021252774;4282.892927676818;4066.1664358806374;4079.571644977279;4088.9182216355657;4098.385242213677;4119.155573107506;4086.4483294755423;4113.087414352341;4117.608827161415;4126.319157339036;4140.468026830077;2732.822366546188;3190.6330771961057;3544.7873127612424;3574.2136729919634;3592.4252119660728;4979.576735977446;5301.390340110898;5306.628536002481;5442.510174084312;5481.75332110056;4641;4661.951061011279;4664.486906440289;4670.322803193552;4677.462091859412;5293.068030168999;5776.451237132465;5798.246227990377;5807.970960145214;5855.0678276168765;3074.8001379910233;3314.8895120134785;3477.7217822574135;3638.1450359165574;3808.6953043756434;6056.910365923749;6130.111133885606;6139.653888630707;6162.969185154046;6163.229596300463;3739.5512538495555;3990.4261751170334;4007.899802504961;4018.9397159042637;4038.51537815464;3928.52857657083;3970.11419575705;4007.2586571483785;4012.8194231259663;4059.3910913363234;4680.859574212779;4685.344051832746;4705.717656940595;4736.739479328601;4754.358161648133;4986.675866068694;5490.254872563718;5913.319968203626;5915.763369465173;5930.940690593039;1284.8201251824753;1299.6750812296925;1312.2979206124678;1321.9801702974464;1327.4557431453059;894.6779159502574;904.5748498205965;921.6175736395406;928.396542247531;928.4475736936512;4477.776111194427;4694;4989.251612258117;5304.541251155963;5356.4107948125675;4658.697184682985;5367.430658611979;5819.330776960619;5910.202122713465;5931.73307201177;4332.631726303236;4724.370266423792;5276.657017293864;5343.545798607084;5365.919511207257;2375.465520257963;2388.6178211486426;2492.2523243027017;2641.300055485298;2662.134806187958;4357.7385356878685;4510.233260345683;4951.455339912607;5186.329040544123;5221.6344855859725;4041.7972205148267;4199.748015119103;4711.882202944954;5176.948230517722;5232.3459567554055;4527.298268768346;4596.897094461292;4919.040787046635;4927.310176575283;5168.664036837594;4673.696209746356;4675.836345727883;4818.831340903052;4987.625928055338;5036.395632524121;3784.905377365588;4240.597143271384;4428.317239448988;4993.950060499348;5037.7733002014265;4437.33439984005;4708.034852855225;5165.225216217447;5173.017126745906;5252.842414727565;3008.879644814183;3121.5473756304755;3465.358908601917;3480.3213373391945;3497.4753786932165;4990.7827885436745;5005.070006044117;5027.924581131359;5030;5142.99711556243;4786.545278198566;5102.540771330598;5700.743466544099;5783.971080144741;5875.794347197828;5098.97450512745;5378.762884536501;5847.970760146172;5862.443067908713;5867.031939729897;5183.574517007853;5417.268668729828;5744.827655170351;5758.884822303614;5769.22115514417;4945.2938736135975;5394.595405344693;5752.497663516384;5865.882682346414;5869.710812782932;5075.670081444694;5696.373398926197;5733.426657334233;5756.366799651951;5801.970990145022 12:17:35 INFO - PROCESS | 1947 | |5;yui.html;627.3600927054401;720.7801620505745;742.6138408027829;757.9886301705476;815.7144999250261;14036.368363423657;14705.852941470583;14743.262836858168;14824.481143159977;17071.14644267788;15582.454614088509;15595.844041559581;15638.296276667548;15681.451149209779;15711.528654140366;859.77645812089;881.9779505512349;882.7572417585184;885.3669626217253;887.8668199770021;682.8634273145391;713;860.8923884514436;878.9077146899548;885.9025507194203;916.4409710076848;927.8422668146432;943.259541260111;944.7921457279422;946.9195118414908;928.4429342394577;930.3952430919888;935.873657056299;936.929730270229;941.9293552983554;700.1528150937372;702.9736584586459;703.5391818358983;704.6159842885588;706.6007705646344;15595.064296142267;15738.685226295525;15769.842301576951;15864;15886.04683718969;13071.934640326832;14252.21612811295;14297.714045719027;14299.57101286963;14308.92845535776;10962.451877406098;11948.65042791309;11963.461644225943;11974.700632484171;12190.39048047603;3773.8867833965023;3799.183175617228;3853.730238883279;3856.84572617095;3863.5750067492554;122350;123083.76916230902;124993;126872;127395;10741.925807419195;10787.784244315228;10811.297265677706;10871.782564348669;11232.438378081064;21709.56580868374;21941.341759747233;21984.340469785933;22012.779872201394;22040.88979555092;7779.105402878741;7782.883256751154;7870.055593328837;7905.604719764104;8015.318697910627;4366.716163449366;4414.624756895636;4424.955750442518;4492.640588752892;4542.613877820356;3532.1346270163463;3627.7097832173363;3657.5976642569294;3668.3947148720163;3782.319182547113;697.4106879686657;706.3995603736782;710.7583421636668;723.616483263871;726.4587882027818;581.4098689829826;601.7863658401204;607.6232735703803;627.2285089340137;657.7040331850686;9439.716808495756;9465.621375144918;9576.138147566753;9583.281253905985;9603.279754018477;619.789271647633;635.3868516881232;642.5791106825037;649.665422307512;670.3865962644126;4444.933326000112;4644.790984405709;4690.695104818176;4695.460022097503;4734.692245004133;156533.2173339126;160500;164086.35913640712;169237.4557880222;171133.14433427755;95914.52042739742;110925;119253.21120183205;135102;143134;83991;87775;92140.6178907317;111069;115289;8926;9754.951225243829;9933.65232216869;10070.521580401304;10185.592576296865;36198.819005905854;39664.61173858901;43592.782036089615;58838.117428237754;61300.38699613125;75685.86471203047;93920;98093;98288;100403;9407.623695052122;12680.112392132462;12921.418536166084;13197.472101115847;13242;14437.85562144407;14762.63093422673;14769.187694676895;14789.964702470723;15414.306356214222;13449.932750336186;13564.366323779244;13636.113652612548;13740.312984350943;13859.168449893039;13521.729565408834;13785.172889626654;13820.239886806323;13963.232022238875;14052.508162214273;10581;13160.868391315964;13410.32948352559;13434.865651343753;13585.35085658287;10511.26421150512;10976.451177440937;11200.439978000904;11324.37715925632;11756.823647645464;7744.806379840549;8603.741887743377;10380.584776608852;11494.885051149382;11579.07367410622 12:17:35 INFO - PROCESS | 1947 | __end_tp_report 12:17:35 INFO - PROCESS | 1947 | __start_cc_report 12:17:35 INFO - PROCESS | 1947 | _x_x_mozilla_cycle_collect,366 12:17:35 INFO - PROCESS | 1947 | __end_cc_report 12:17:35 INFO - PROCESS | 1947 | __startTimestamp1475522255624__endTimestamp 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | ------- Summary: start ------- 12:17:35 INFO - PROCESS | 1947 | Number of tests: 6 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | [#0] dojo.html Cycles:165 Average:5687.89 Median:5929.56 stddev:720.01 (12.1%) stddev-sans-first:698.49 12:17:35 INFO - PROCESS | 1947 | Values: 3351.0 3372.0 3390.0 3396.7 3402.1 5627.2 5699.7 5739.5 5745.2 5783.5 5643.6 5740.6 5760.9 5838.3 5848.3 5169.9 5178.5 5266.6 5299.7 5346.1 5315.8 5343.0 5370.0 5375.4 5412.9 3827.4 5133.7 5178.2 5187.2 5223.1 5205.8 5223.5 5225.6 5255.0 5290.4 4240.4 5192.3 5210.2 5222.4 5241.5 5239.6 5411.4 5649.4 5651.6 5719.8 6200.3 6235.9 6237.2 6250.7 6258.0 6290.2 6293.3 6297.1 6306.6 6314.2 5618.6 5646.4 5732.6 5834.1 5861.5 6153.5 6230.3 6247.3 6254.5 6264.1 5921.8 5929.6 5993.1 6021.5 6065.1 6096.8 6150.2 6159.9 6171.4 6179.2 5342.3 6212.3 6230.6 6239.6 6249.1 6195.8 6212.3 6227.7 6231.2 6253.5 4853.7 4908.4 4912.1 4935.8 4952.3 3533.4 3701.8 3712.9 3740.9 4316.2 5432.3 5694.4 5742.3 5776.9 5780.6 6103.7 6127.5 6212.2 6243.9 6256.7 5781.9 5792.2 5839.5 5865.2 5926.6 4447.8 4472.4 5362.2 5388.0 5393.1 6149.3 6314.0 6336.5 6345.0 6366.6 5393.5 6118.4 6203.2 6247.2 6256.3 6307.2 6313.2 6327.3 6328.1 6333.5 6089.3 6090.6 6148.8 6181.1 6195.6 6216.9 6256.7 6264.7 6281.8 6299.4 6161.8 6177.6 6184.8 6200.8 6207.7 5022.4 6117.4 6157.8 6164.6 6165.3 5005.6 5907.9 5955.1 6004.2 6130.0 5744.7 6149.7 6158.4 6159.0 6214.9 6036.9 6077.2 6083.1 6091.2 6097.6 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | [#1] ext.html Cycles:180 Average:69065.66 Median:39184.21 stddev:154690.59 (394.8%) stddev-sans-first:155038.77 12:17:35 INFO - PROCESS | 1947 | Values: 455.5 462.6 483.9 511.0 537.4 38713.0 40372.0 40413.2 42835.8 42891.4 41940.8 42365.0 42441.8 42489.8 42541.0 8578.3 9798.1 9801.8 9825.4 9858.4 9669.1 9804.5 9811.3 9829.7 9843.2 8397.7 9828.0 9832.0 9837.3 9869.9 9752.7 9762.0 9789.3 9791.3 9824.3 9607.7 9701.2 9712.9 9720.4 9723.1 40029.0 40258.4 40459.0 40474.4 40490.6 3381.4 3392.3 3417.4 3425.2 3684.6 21731.9 23774.0 24751.4 25324.0 29713.6 2556.4 3234.4 3255.1 3299.4 3355.4 379707.0 501933.0 503380.0 503650.0 504748.5 55535.4 55712.9 55838.0 55901.2 55920.2 34610.5 34674.7 34732.0 35384.0 35424.6 16302.0 16303.5 16494.4 16510.5 16549.8 12374.7 12690.7 12773.9 12784.1 12803.0 18331.7 18428.2 18482.2 18494.4 18579.3 7771.5 7898.2 7910.6 7941.4 7956.5 832.6 906.3 946.7 949.4 1066.0 27578.9 29611.3 29727.1 30854.4 31003.8 967.1 1035.0 1069.9 1076.4 1124.6 15500.5 15575.8 15607.6 15613.6 15804.2 643770.0 647740.0 648100.0 648971.0 650157.0 55056.0 56099.4 56111.9 56264.0 56265.7 1317.7 1337.2 1352.5 1355.3 1362.8 27127.1 28451.9 29559.1 30270.2 30297.5 43736.6 44157.6 44302.6 44365.8 44589.8 590516.0 590807.0 592103.0 592566.0 592844.0 23974.2 24013.0 24225.6 24228.4 24252.8 37580.4 45364.0 45644.5 46833.5 47295.3 38233.0 38571.6 39180.0 39188.4 39296.0 31114.8 37622.0 37929.4 38261.0 38381.8 29068.9 37773.6 37872.9 37983.0 38372.4 31843.0 33648.0 33772.7 34276.5 34376.7 25279.9 25446.9 25621.1 25703.0 25820.4 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | [#2] jquery.html Cycles:180 Average:35471.38 Median:13747.09 stddev:101239.13 (736.4%) stddev-sans-first:101488.72 12:17:35 INFO - PROCESS | 1947 | Values: 314.4 378.2 387.7 391.8 411.4 18986.6 19090.6 20073.5 20115.9 20277.2 20028.5 20240.5 20296.3 20444.4 20846.8 5239.4 5658.7 5853.8 5929.1 6485.3 6564.7 6643.8 6645.9 6660.2 6666.3 5343.9 5458.8 5589.9 5592.4 5931.7 4825.5 4902.5 5814.0 5954.0 5957.3 4762.4 5677.4 5686.3 5714.7 5731.3 12566.4 12786.4 16205.8 25229.9 25528.7 2225.5 2241.1 2264.3 2669.6 2981.6 9568.4 9829.0 9849.1 10104.1 10409.1 1793.9 1813.4 1879.9 1891.6 1950.2 121809.0 125053.4 131819.0 136938.6 137461.0 9990.9 10731.5 10941.4 11094.6 11202.8 12721.2 13946.5 13957.6 13994.9 14005.2 8342.4 8516.9 8535.9 8607.7 8654.6 7661.5 8470.9 8552.2 8559.2 8683.9 4351.7 4427.8 4434.6 4493.8 4542.4 1490.1 1715.4 1793.2 1861.9 1920.9 723.9 843.4 849.8 876.5 960.8 19502.6 20199.9 20363.4 20367.8 20600.2 859.9 885.4 918.9 956.6 963.9 10452.8 10870.8 10886.3 10892.4 10955.7 589505.0 600345.0 601381.0 610779.0 614143.0 123689.0 132930.3 134565.0 136353.0 138574.6 1031.1 1037.7 1044.7 1097.5 1099.5 18554.4 19149.7 19283.9 19394.6 19429.6 38809.4 52710.0 54293.2 55696.7 56948.3 83738.7 83867.0 84240.6 84414.6 85435.0 7855.5 7943.7 7987.8 8130.6 8227.5 10392.8 11276.4 11731.7 11772.3 12003.2 9981.7 10202.4 10860.7 11131.7 11157.1 10817.1 10881.3 10967.5 11230.8 11307.9 10372.3 10968.6 11047.2 11086.9 11192.6 7788.6 7872.8 7948.0 8169.5 8204.1 10391.5 10721.3 10816.1 11025.6 11265.9 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | [#3] mootools.html Cycles:180 Average:5693.76 Median:4928.12 stddev:3179.08 (64.5%) stddev-sans-first:3170.84 12:17:35 INFO - PROCESS | 1947 | Values: 1298.4 1372.8 1440.9 1836.8 1867.4 7942.5 8030.1 8211.6 8320.3 9033.5 8445.7 8751.6 8770.0 8892.0 8911.9 2399.2 2424.1 2431.3 2436.8 2455.3 2025.9 2414.5 2436.0 2453.5 2454.0 2416.3 2423.6 2431.8 2448.4 2451.7 2374.3 2384.2 2391.6 2396.9 2433.1 2397.9 2414.8 2418.3 2428.6 2433.0 7479.3 7497.6 8867.5 8945.5 8970.1 5259.6 5412.1 5413.2 5418.3 5441.0 3178.2 3452.2 3694.5 3752.4 3754.4 1073.3 1112.5 1118.3 1132.9 1133.5 11753.5 11827.1 11856.2 11878.7 11896.2 4528.6 4697.1 4840.0 4870.8 4896.3 8264.4 9895.9 9979.1 9980.7 10003.5 5376.1 5401.8 5426.0 5437.5 5441.5 4424.2 4575.5 4771.0 4923.7 4974.8 3935.2 3969.9 4048.5 4073.9 4076.7 1330.6 1344.5 1348.5 1359.7 1363.4 742.0 833.5 907.0 914.7 944.6 5724.8 5796.9 5929.7 5960.5 6056.7 892.0 921.8 940.9 962.2 988.2 3915.6 3936.5 3999.6 4030.2 4030.9 10580.6 10824.5 10930.7 10940.2 10973.4 10856.8 10857.9 10874.3 10898.2 10904.4 7685.3 8036.5 8057.1 8159.8 8172.6 5882.7 5886.9 5947.2 6081.7 6185.8 9941.9 10204.2 10221.8 10245.8 10249.7 9926.0 10041.6 10170.0 10420.2 10495.4 6956.5 7146.5 7397.7 7473.5 7679.7 6527.5 6934.3 7347.5 8298.9 8358.7 7395.7 7500.6 7508.5 7561.9 7638.1 7089.2 7226.9 7281.7 7304.7 7396.1 6884.2 6913.0 6977.9 6993.5 6999.0 4330.9 4788.1 4839.5 4933.2 4938.4 4932.6 4960.9 5000.8 5042.0 5058.8 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | [#4] prototype.html Cycles:180 Average:4415.42 Median:4770.45 stddev:1368.47 (28.7%) stddev-sans-first:1336.38 12:17:35 INFO - PROCESS | 1947 | Values: 265.0 280.2 315.4 316.9 317.9 4656.4 4818.2 5101.5 5112.1 5690.0 4346.5 4861.8 5486.4 5507.6 5568.4 4237.9 4252.7 4263.3 4273.3 4283.0 3850.0 3904.6 3907.0 4087.6 4282.9 4066.2 4079.6 4088.9 4098.4 4119.2 4086.4 4113.1 4117.6 4126.3 4140.5 2732.8 3190.6 3544.8 3574.2 3592.4 4979.6 5301.4 5306.6 5442.5 5481.8 4641.0 4662.0 4664.5 4670.3 4677.5 5293.1 5776.5 5798.2 5808.0 5855.1 3074.8 3314.9 3477.7 3638.1 3808.7 6056.9 6130.1 6139.7 6163.0 6163.2 3739.6 3990.4 4007.9 4018.9 4038.5 3928.5 3970.1 4007.3 4012.8 4059.4 4680.9 4685.3 4705.7 4736.7 4754.4 4986.7 5490.3 5913.3 5915.8 5930.9 1284.8 1299.7 1312.3 1322.0 1327.5 894.7 904.6 921.6 928.4 928.4 4477.8 4694.0 4989.3 5304.5 5356.4 4658.7 5367.4 5819.3 5910.2 5931.7 4332.6 4724.4 5276.7 5343.5 5365.9 2375.5 2388.6 2492.3 2641.3 2662.1 4357.7 4510.2 4951.5 5186.3 5221.6 4041.8 4199.7 4711.9 5176.9 5232.3 4527.3 4596.9 4919.0 4927.3 5168.7 4673.7 4675.8 4818.8 4987.6 5036.4 3784.9 4240.6 4428.3 4994.0 5037.8 4437.3 4708.0 5165.2 5173.0 5252.8 3008.9 3121.5 3465.4 3480.3 3497.5 4990.8 5005.1 5027.9 5030.0 5143.0 4786.5 5102.5 5700.7 5784.0 5875.8 5099.0 5378.8 5848.0 5862.4 5867.0 5183.6 5417.3 5744.8 5758.9 5769.2 4945.3 5394.6 5752.5 5865.9 5869.7 5075.7 5696.4 5733.4 5756.4 5802.0 12:17:35 INFO - PROCESS | 1947 | 12:17:35 INFO - PROCESS | 1947 | [#5] yui.html Cycles:180 Average:24827.46 Median:3721.14 stddev:40741.47 (1094.9%) stddev-sans-first:40815.24 12:17:35 INFO - PROCESS | 1947 | Values: 627.4 720.8 742.6 758.0 815.7 14036.4 14705.9 14743.3 14824.5 17071.1 15582.5 15595.8 15638.3 15681.5 15711.5 859.8 882.0 882.8 885.4 887.9 682.9 713.0 860.9 878.9 885.9 916.4 927.8 943.3 944.8 946.9 928.4 930.4 935.9 936.9 941.9 700.2 703.0 703.5 704.6 706.6 15595.1 15738.7 15769.8 15864.0 15886.0 13071.9 14252.2 14297.7 14299.6 14308.9 10962.5 11948.7 11963.5 11974.7 12190.4 3773.9 3799.2 3853.7 3856.8 3863.6 122350.0 123083.8 124993.0 126872.0 127395.0 10741.9 10787.8 10811.3 10871.8 11232.4 21709.6 21941.3 21984.3 22012.8 22040.9 7779.1 7782.9 7870.1 7905.6 8015.3 4366.7 4414.6 4425.0 4492.6 4542.6 3532.1 3627.7 3657.6 3668.4 3782.3 697.4 706.4 710.8 723.6 726.5 581.4 601.8 607.6 627.2 657.7 9439.7 9465.6 9576.1 9583.3 9603.3 619.8 635.4 642.6 649.7 670.4 4444.9 4644.8 4690.7 4695.5 4734.7 156533.2 160500.0 164086.4 169237.5 171133.1 95914.5 110925.0 119253.2 135102.0 143134.0 83991.0 87775.0 92140.6 111069.0 115289.0 8926.0 9755.0 9933.7 10070.5 10185.6 36198.8 39664.6 43592.8 58838.1 61300.4 75685.9 93920.0 98093.0 98288.0 100403.0 9407.6 12680.1 12921.4 13197.5 13242.0 14437.9 14762.6 14769.2 14790.0 15414.3 13449.9 13564.4 13636.1 13740.3 13859.2 13521.7 13785.2 13820.2 13963.2 14052.5 10581.0 13160.9 13410.3 13434.9 13585.4 10511.3 10976.5 11200.4 11324.4 11756.8 7744.8 8603.7 10380.6 11494.9 11579.1 12:17:35 INFO - PROCESS | 1947 | -------- Summary: end -------- 12:17:35 INFO - PROCESS | 1947 | 12:17:36 INFO - TEST-INFO | 1947: exit 0 12:17:36 INFO - TEST-OK | dromaeo_css | took 1113565ms 12:17:36 INFO - TEST-START | kraken 12:17:36 INFO - operating with platform_type : mac_ 12:17:36 INFO - Initialising browser for kraken test... 12:17:36 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpze3VVL/profile http://localhost:52722/getInfo.html) 12:17:38 INFO - PROCESS | 1953 | __metrics Screen width/height:1600/1200 12:17:38 INFO - PROCESS | 1953 | colorDepth:24 12:17:38 INFO - PROCESS | 1953 | Browser inner width/height: 1024/689 12:17:38 INFO - PROCESS | 1953 | __metrics 12:17:39 ERROR - PROCESS | 1953 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 12:17:39 INFO - TEST-INFO | 1953: exit 0 12:17:39 INFO - Browser initialized. 12:17:39 INFO - Running cycle 1/1 for kraken test... 12:17:39 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpze3VVL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:17:51 INFO - PROCESS | 1955 | RSS: Main: 243605504 12:17:51 INFO - PROCESS | 1955 | 12:17:54 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52722/tests/kraken/driver.html?testName=audio-beat-detection) 12:17:55 INFO - PROCESS | 1955 | RSS: Main: 255709184 12:17:55 INFO - PROCESS | 1955 | 12:17:58 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52722/tests/kraken/driver.html?testName=audio-dft) 12:17:59 INFO - PROCESS | 1955 | RSS: Main: 263270400 12:17:59 INFO - PROCESS | 1955 | 12:18:02 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52722/tests/kraken/driver.html?testName=audio-fft) 12:18:03 INFO - PROCESS | 1955 | RSS: Main: 262184960 12:18:03 INFO - PROCESS | 1955 | 12:18:05 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52722/tests/kraken/driver.html?testName=audio-oscillator) 12:18:06 INFO - PROCESS | 1955 | RSS: Main: 264130560 12:18:06 INFO - PROCESS | 1955 | 12:18:08 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52722/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:18:08 INFO - PROCESS | 1955 | RSS: Main: 264445952 12:18:08 INFO - PROCESS | 1955 | 12:18:11 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52722/tests/kraken/driver.html?testName=imaging-darkroom) 12:18:12 INFO - PROCESS | 1955 | RSS: Main: 265580544 12:18:12 INFO - PROCESS | 1955 | 12:18:15 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52722/tests/kraken/driver.html?testName=imaging-desaturate) 12:18:16 INFO - PROCESS | 1955 | RSS: Main: 265363456 12:18:16 INFO - PROCESS | 1955 | 12:18:19 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52722/tests/kraken/driver.html?testName=json-parse-financial) 12:18:19 INFO - PROCESS | 1955 | RSS: Main: 265367552 12:18:19 INFO - PROCESS | 1955 | 12:18:21 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52722/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:18:21 INFO - PROCESS | 1955 | RSS: Main: 264724480 12:18:21 INFO - PROCESS | 1955 | 12:18:23 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:18:24 INFO - PROCESS | 1955 | RSS: Main: 264744960 12:18:24 INFO - PROCESS | 1955 | 12:18:26 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:18:27 INFO - PROCESS | 1955 | RSS: Main: 264806400 12:18:27 INFO - PROCESS | 1955 | 12:18:30 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:18:30 INFO - PROCESS | 1955 | RSS: Main: 265084928 12:18:30 INFO - PROCESS | 1955 | 12:18:33 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:18:34 INFO - PROCESS | 1955 | RSS: Main: 264978432 12:18:34 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | Cycle 1(1): loaded http://localhost:52722/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52722/tests/kraken/driver.html?testName=ai-astar) 12:18:36 INFO - PROCESS | 1955 | RSS: Main: 266616832 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | __start_tp_report 12:18:36 INFO - PROCESS | 1955 | _x_x_mozilla_page_load 12:18:36 INFO - PROCESS | 1955 | _x_x_mozilla_page_load_details 12:18:36 INFO - PROCESS | 1955 | |i|pagename|runs| 12:18:36 INFO - PROCESS | 1955 | |0;ai-astar;115;116;118;118;117;115;174;153;116;97 12:18:36 INFO - PROCESS | 1955 | |1;audio-beat-detection;162;140;125;148;119;143;145;117;157;145 12:18:36 INFO - PROCESS | 1955 | |2;audio-dft;212;252;197;272;284;207;271;269;196;194 12:18:36 INFO - PROCESS | 1955 | |3;audio-fft;83;60;58;85;72;85;83;81;88;64 12:18:36 INFO - PROCESS | 1955 | |4;audio-oscillator;113;105;125;80;70;72;91;71;73;87 12:18:36 INFO - PROCESS | 1955 | |5;imaging-gaussian-blur;90;79;78;116;133;133;89;86;106;116 12:18:36 INFO - PROCESS | 1955 | |6;imaging-darkroom;95;104;152;91;151;96;101;96;96;123 12:18:36 INFO - PROCESS | 1955 | |7;imaging-desaturate;98;93;115;116;93;93;93;90;92;93 12:18:36 INFO - PROCESS | 1955 | |8;json-parse-financial;58;55;57;57;57;58;58;55;58;56 12:18:36 INFO - PROCESS | 1955 | |9;json-stringify-tinderbox;71;73;78;78;69;67;69;71;70;72 12:18:36 INFO - PROCESS | 1955 | |10;stanford-crypto-aes;88;89;87;95;87;88;92;91;87;88 12:18:36 INFO - PROCESS | 1955 | |11;stanford-crypto-ccm;142;156;144;140;142;139;138;138;181;141 12:18:36 INFO - PROCESS | 1955 | |12;stanford-crypto-pbkdf2;174;170;168;166;174;173;168;161;220;175 12:18:36 INFO - PROCESS | 1955 | |13;stanford-crypto-sha256-iterative;69;61;70;68;69;71;71;67;68;74 12:18:36 INFO - PROCESS | 1955 | __end_tp_report 12:18:36 INFO - PROCESS | 1955 | __start_cc_report 12:18:36 INFO - PROCESS | 1955 | _x_x_mozilla_cycle_collect,959 12:18:36 INFO - PROCESS | 1955 | __end_cc_report 12:18:36 INFO - PROCESS | 1955 | __startTimestamp1475522316313__endTimestamp 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | ------- Summary: start ------- 12:18:36 INFO - PROCESS | 1955 | Number of tests: 14 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#0] ai-astar Cycles:10 Average:123.90 Median:118.00 stddev:22.31 (18.9%) stddev-sans-first:23.43 12:18:36 INFO - PROCESS | 1955 | Values: 115.0 116.0 118.0 118.0 117.0 115.0 174.0 153.0 116.0 97.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:145.00 stddev:15.24 (10.5%) stddev-sans-first:13.96 12:18:36 INFO - PROCESS | 1955 | Values: 162.0 140.0 125.0 148.0 119.0 143.0 145.0 117.0 157.0 145.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#2] audio-dft Cycles:10 Average:235.40 Median:260.50 stddev:37.22 (14.3%) stddev-sans-first:38.50 12:18:36 INFO - PROCESS | 1955 | Values: 212.0 252.0 197.0 272.0 284.0 207.0 271.0 269.0 196.0 194.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#3] audio-fft Cycles:10 Average:75.90 Median:83.00 stddev:11.40 (13.7%) stddev-sans-first:11.79 12:18:36 INFO - PROCESS | 1955 | Values: 83.0 60.0 58.0 85.0 72.0 85.0 83.0 81.0 88.0 64.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:72.50 stddev:19.57 (27.0%) stddev-sans-first:18.67 12:18:36 INFO - PROCESS | 1955 | Values: 113.0 105.0 125.0 80.0 70.0 72.0 91.0 71.0 73.0 87.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#5] imaging-gaussian-blur Cycles:10 Average:102.60 Median:78.50 stddev:21.08 (26.9%) stddev-sans-first:21.86 12:18:36 INFO - PROCESS | 1955 | Values: 90.0 79.0 78.0 116.0 133.0 133.0 89.0 86.0 106.0 116.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#6] imaging-darkroom Cycles:10 Average:110.50 Median:93.00 stddev:23.34 (25.1%) stddev-sans-first:24.07 12:18:36 INFO - PROCESS | 1955 | Values: 95.0 104.0 152.0 91.0 151.0 96.0 101.0 96.0 96.0 123.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#7] imaging-desaturate Cycles:10 Average:97.60 Median:93.00 stddev:9.64 (10.4%) stddev-sans-first:10.22 12:18:36 INFO - PROCESS | 1955 | Values: 98.0 93.0 115.0 116.0 93.0 93.0 93.0 90.0 92.0 93.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.50 stddev:1.20 (2.1%) stddev-sans-first:1.20 12:18:36 INFO - PROCESS | 1955 | Values: 58.0 55.0 57.0 57.0 57.0 58.0 58.0 55.0 58.0 56.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:71.50 stddev:3.68 (5.1%) stddev-sans-first:3.89 12:18:36 INFO - PROCESS | 1955 | Values: 71.0 73.0 78.0 78.0 69.0 67.0 69.0 71.0 70.0 72.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:88.50 stddev:2.66 (3.0%) stddev-sans-first:2.78 12:18:36 INFO - PROCESS | 1955 | Values: 88.0 89.0 87.0 95.0 87.0 88.0 92.0 91.0 87.0 88.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:142.00 stddev:13.33 (9.4%) stddev-sans-first:14.05 12:18:36 INFO - PROCESS | 1955 | Values: 142.0 156.0 144.0 140.0 142.0 139.0 138.0 138.0 181.0 141.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:173.50 stddev:16.43 (9.5%) stddev-sans-first:17.43 12:18:36 INFO - PROCESS | 1955 | Values: 174.0 170.0 168.0 166.0 174.0 173.0 168.0 161.0 220.0 175.0 12:18:36 INFO - PROCESS | 1955 | 12:18:36 INFO - PROCESS | 1955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.50 stddev:3.39 (4.9%) stddev-sans-first:3.60 12:18:36 INFO - PROCESS | 1955 | Values: 69.0 61.0 70.0 68.0 69.0 71.0 71.0 67.0 68.0 74.0 12:18:36 INFO - PROCESS | 1955 | -------- Summary: end -------- 12:18:36 INFO - PROCESS | 1955 | 12:18:37 INFO - TEST-INFO | 1955: exit 0 12:18:37 INFO - TEST-OK | kraken | took 61044ms 12:18:37 INFO - SUITE-END | took 1174s 12:18:37 INFO - Completed test suite (00:19:34) 12:18:37 INFO - javascript benchmark 12:18:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7263.416267502235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3350.977951724723, 3372.0, 3389.9830050984697, 3396.728261739061, 3402.1494626343406, 5627.212190293352, 5699.68651724155, 5739.512141467975, 5745.224394706714, 5783.5373170146395, 5643.5767317451255, 5740.569457290699, 5760.913586296198, 5838.328592211897, 5848.2689663792025, 5169.870753231162, 5178.456262092483, 5266.605004624668, 5299.655522391052, 5346.117890548055, 5315.840524784263, 5343.038253114438, 5369.973150134244, 5375.381831089436, 5412.91880621791, 3827.445020472016, 5133.717645529495, 5178.223266510016, 5187.170052791555, 5223.085959956992, 5205.791768329263, 5223.4776522347465, 5225.634205605609, 5254.973725131388, 5290.365156181283, 4240.38514415408, 5192.273081768555, 5210.218467229908, 5222.399424066205, 5241.475852414728, 5239.633225674204, 5411.404745477994, 5649.406812284692, 5651.632643878134, 5719.828405147852, 6200.348963358872, 6235.937640623626, 6237.157983672191, 6250.749970001195, 6258.0, 6290.150829637986, 6293.339199384044, 6297.149884765589, 6306.621602703853, 6314.179156709644, 5618.634788738719, 5646.378898321182, 5732.570057245724, 5834.095715164156, 5861.531077513831, 6153.476954458832, 6230.252369715663, 6247.250329960343, 6254.499640028877, 6264.091706702503, 5921.792737254175, 5929.555283353766, 5993.130996005642, 6021.458068773832, 6065.059915713072, 6096.829073522031, 6150.231221097363, 6159.907601385983, 6171.444569988723, 6179.196704428396, 5342.2787923630585, 6212.285587157445, 6230.626162430269, 6239.594426362272, 6249.125122482856, 6195.845103872349, 6212.347703491158, 6227.719752611143, 6231.22109736283, 6253.468455181361, 4853.733044682576, 4908.3619129513645, 4912.091263116335, 4935.777889994959, 4952.281919121707, 3533.434650455915, 3701.833417496165, 3712.9232522568154, 3740.869069582606, 4316.223079845658, 5432.266644003009, 5694.402087780723, 5742.339630942495, 5776.855578610568, 5780.624259423124, 6103.6948152592195, 6127.494965205055, 6212.223472065992, 6243.937560624427, 6256.655883926428, 5781.8554536136935, 5792.218050563204, 5839.532837373, 5865.178874957509, 5926.555508336892, 4447.844325448594, 4472.44094488189, 5362.222477740784, 5387.9770036260425, 5393.083175860113, 6149.292831324455, 6313.968430157912, 6336.52476064297, 6345.0, 6366.618002919747, 5393.487618676219, 6118.418750218722, 6203.193584833943, 6247.156633854554, 6256.343083976117, 6307.24313082433, 6313.242410910537, 6327.272363678236, 6328.082428047999, 6333.461655759312, 6089.33017368098, 6090.636117690217, 6148.815535533941, 6181.072839074175, 6195.628262304276, 6216.906746398898, 6256.687165641791, 6264.686765661608, 6281.842953926189, 6299.401556852092, 6161.753529858755, 6177.567570270038, 6184.845378865564, 6200.81397558074, 6207.689615519296, 5022.447530771686, 6117.357677443804, 6157.753689852535, 6164.630122192682, 6165.260168779775, 5005.624578156726, 5907.852303692442, 5955.136505206808, 6004.159417681441, 6130.0, 5744.684042377709, 6149.661768602769, 6158.384161583985, 6159.043659043595, 6214.9067763982675, 6036.879262414639, 6077.20996270482, 6083.057126145454, 6091.208142941389, 6097.603655762361], "value": 5638.320549452648, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.5308032726293, 462.5813638657016, 483.87177397989564, 510.9933431140654, 537.414218501833, 38713.03217419562, 40371.99070023247, 40413.19173616526, 42835.78582107085, 42891.35662965058, 41940.79029604848, 42365.0, 42441.787791061004, 42489.838973348844, 42541.0, 8578.270846978014, 9798.069183427562, 9801.803963920718, 9825.361351512129, 9858.359206651581, 9669.081437263449, 9804.509774511282, 9811.313208075437, 9829.67299414577, 9843.212542996544, 8397.748067557952, 9828.0, 9832.016798320146, 9837.262205334593, 9869.851952220723, 9752.707418777483, 9761.951190244039, 9789.265805064648, 9791.314607977445, 9824.312298139133, 9607.711768646952, 9701.223902087817, 9712.902870971271, 9720.368176068603, 9723.076307750753, 40028.99927501807, 40258.39612405816, 40458.98852528681, 40474.39288410676, 40490.59509404898, 3381.3575420669995, 3392.3215356928713, 3417.3507033663773, 3425.1950791563963, 3684.613115622875, 21731.891340543356, 23774.0, 24751.381215469577, 25324.0, 29713.55429668535, 2556.401480757136, 3234.433974054531, 3255.088575198948, 3299.406106900757, 3355.446351352024, 379707.0, 501933.0, 503380.0, 503650.0, 504748.47625761636, 55535.444645553835, 55712.85742851446, 55838.0, 55901.161482577794, 55920.16119758207, 34610.48084278738, 34674.653253467644, 34732.0, 35384.0, 35424.645753542136, 16302.0, 16303.510894673178, 16494.42269520561, 16510.504684859472, 16549.751753723704, 12374.690632734073, 12690.746185076247, 12773.936130319289, 12784.105112642026, 12803.03977201695, 18331.725024124647, 18428.170732317078, 18482.168302426155, 18494.352697655788, 18579.32786049262, 7771.533707977426, 7898.249666281694, 7910.5649189295145, 7941.404394670423, 7956.482828616237, 832.6045128564004, 906.2749800159977, 946.7159852044359, 949.4113649537331, 1065.9786804263872, 27578.89684412601, 29611.25971850678, 29727.10818675443, 30854.38291234163, 31003.844980775404, 967.0957654592978, 1034.99482502587, 1069.8876617955002, 1076.4187338837096, 1124.6344937895217, 15500.457483988006, 15575.844241557666, 15607.609809754847, 15613.609659758597, 15804.209789510709, 643770.0, 647740.0, 648100.0, 648971.0, 650157.0, 55056.0, 56099.439005610235, 56111.87776244452, 56264.0, 56265.71867140638, 1317.6903427694483, 1337.2110454831502, 1352.513095285716, 1355.349432272495, 1362.754704153242, 27127.050553230543, 28451.857740711162, 29559.113226603236, 30270.243243919078, 30297.545536817408, 43736.56263437325, 44157.55842441534, 44302.55697442984, 44365.77817110894, 44589.777051114535, 590516.0, 590807.0, 592103.0, 592566.0, 592844.0, 23974.160904368262, 24013.0, 24225.63661545043, 24228.394290142183, 24252.75747242505, 37580.43629345507, 45364.0, 45644.54355456403, 46833.531664682916, 47295.29057064216, 38233.0, 38571.614283856805, 39180.0, 39188.41217381799, 39296.0, 31114.844425777726, 37622.0, 37929.4310585347, 38261.0, 38381.80809095937, 29068.854655726587, 37773.62226377701, 37872.86381408562, 37983.0, 38372.42441363438, 31843.0, 33647.99056028323, 33772.662273376955, 34276.48585271273, 34376.656233437345, 25279.87360063188, 25446.872765636053, 25621.05599488804, 25703.0, 25820.35449113787], "value": 19284.578499268035, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.40106596932844, 378.1718037497878, 387.73246459942635, 391.7590681730737, 411.3911411111555, 18986.62026759464, 19090.61624996902, 20073.498162545944, 20115.899420502894, 20277.188912443522, 20028.499287517818, 20240.493987650316, 20296.28962986292, 20444.386668399933, 20846.791532084673, 5239.397469291023, 5658.7170641467965, 5853.76584936602, 5929.051351783715, 6485.286618471964, 6564.7045882935145, 6643.833904152387, 6645.867082658344, 6660.167479065117, 6666.333366663343, 5343.919841202385, 5458.808941687042, 5589.916151257735, 5592.412796656354, 5931.673757943311, 4825.517448255181, 4902.509749025105, 5814.011618024946, 5953.970230148843, 5957.31490878548, 4762.357081793983, 5677.432256774289, 5686.260786097822, 5714.657120572738, 5731.340895796953, 12566.434510446961, 12786.360681965865, 16205.837941620552, 25229.87385063063, 25528.744712552823, 2225.5326381459913, 2241.148363621813, 2264.30938563738, 2669.626252324676, 2981.6272965879266, 9568.425894446356, 9829.0, 9849.064338887794, 10104.141148002429, 10409.115225205867, 1793.9192736326897, 1813.4313818546862, 1879.9248030078782, 1891.5743957609566, 1950.1906708715867, 121809.0, 125053.37473312575, 131819.02271465937, 136938.6306136936, 137461.0, 9990.851052128954, 10731.517081731341, 10941.398223097805, 11094.55621775136, 11202.775944481227, 12721.173123746927, 13946.511872084631, 13957.58127256184, 13994.930025350011, 14005.229712365917, 8342.37432192588, 8516.8722469163, 8535.914640853513, 8607.698730544402, 8654.567271636393, 7661.46369754123, 8470.915290847013, 8552.230299273095, 8559.186877246651, 8683.869741953877, 4351.73889566627, 4427.845025424094, 4434.600885920283, 4493.775311234425, 4542.409486766699, 1490.1431676785892, 1715.3738885307023, 1793.2378739035858, 1861.897595632226, 1920.8847469151895, 723.869703453373, 843.409613270713, 849.7790574450687, 876.4565969099199, 960.7646126698863, 19502.609947801247, 20199.899000505196, 20363.389098327072, 20367.796322036887, 20600.175992960114, 859.9484030958163, 885.4333226734894, 918.9264858811279, 956.6316967967383, 963.8602402651576, 10452.843207351896, 10870.836937445945, 10886.346819190874, 10892.40091794943, 10955.671329860117, 589505.0, 600345.0, 601381.0, 610779.0, 614143.0, 123689.0, 132930.33534832264, 134565.0, 136353.0, 138574.6142538582, 1031.097789434245, 1037.6731329631143, 1044.7283706236433, 1097.4512743628186, 1099.4997276239292, 18554.44336669902, 19149.712754308417, 19283.90358048257, 19394.612107757483, 19429.61140777148, 38809.41785873158, 52710.0, 54293.185602216785, 55696.72151639216, 56948.291551253526, 83738.74391884249, 83867.0, 84240.57879710807, 84414.57792710997, 85435.0, 7855.5286682799215, 7943.682252709827, 7987.84024319522, 8130.593470326342, 8227.465214761021, 10392.804827444941, 11276.436178191221, 11731.706707332043, 11772.293662380285, 12003.219790713576, 9981.650642227487, 10202.438865862448, 10860.67417977462, 11131.664200296016, 11157.10743140563, 10817.1346292298, 10881.292715973437, 10967.477480179445, 11230.83153752678, 11307.886921131012, 10372.325798823053, 10968.616098436516, 11047.226694131334, 11086.889131108908, 11192.608258710907, 7788.649510771916, 7872.84254314922, 7947.9732668171555, 8169.5098294102545, 8204.056533498724, 10391.480425978822, 10721.30311529748, 10816.08063314627, 11025.558977640805, 11265.943670281596], "value": 9414.560459700073, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.415712929182, 1372.8352597688279, 1440.933709055299, 1836.7704036995376, 1867.4117652939315, 7942.523448593089, 8030.116687164407, 8211.63047662855, 8320.33437325014, 9033.457992520453, 8445.746627601166, 8751.649934002633, 8770.0, 8891.955540222307, 8911.91088089119, 2399.196269249803, 2424.127314166907, 2431.258466167818, 2436.8294219404647, 2455.3493324269084, 2025.8885761283123, 2414.468816860288, 2436.013414567103, 2453.50929814037, 2453.9938625163686, 2416.250962201714, 2423.6243382275775, 2431.817613678981, 2448.436859522311, 2451.656768052474, 2374.27584586701, 2384.1893756122913, 2391.6173412253956, 2396.940076498084, 2433.0632706407982, 2397.8920948557356, 2414.7826695597305, 2418.262429958862, 2428.5871401861727, 2432.987835060831, 7479.32686058252, 7497.550146991198, 8867.512286824222, 8945.46327220369, 8970.147835955639, 5259.5529380002745, 5412.134058550652, 5413.160960051159, 5418.2685337479725, 5441.020616289066, 3178.2054486378406, 3452.154222215548, 3694.538182727159, 3752.418375151856, 3754.3805272130066, 1073.259450978822, 1112.5494174859195, 1118.2507719827736, 1132.9263597866113, 1133.5012594458412, 11753.4710938008, 11827.112966527546, 11856.22934509254, 11878.703032424171, 11896.22674526153, 4528.6150677192145, 4697.13103075932, 4840.00779840132, 4870.805167793249, 4896.2655601660035, 8264.421490495728, 9895.851562226573, 9979.10188083076, 9980.700578982642, 10003.499825008721, 5376.1129413647095, 5401.756920938488, 5425.972870135624, 5437.537809286176, 5441.455854414527, 4424.203643344229, 4575.473820510684, 4771.045790841846, 4923.679960802537, 4974.801007959713, 3935.193285376491, 3969.940450893239, 4048.473698419187, 4073.857414990461, 4076.673866090765, 1330.6141219046563, 1344.5159742492694, 1348.5347555093476, 1359.7076628524915, 1363.3592211660505, 742.046470285691, 833.5207255827924, 906.9501177435304, 914.6570036236411, 944.5843828715343, 5724.8282551523525, 5796.94203057964, 5929.673867937305, 5960.493358064613, 6056.727447264883, 892.0, 921.760342311004, 940.8965013848472, 962.2494454325637, 988.2341185581232, 3915.569287378386, 3936.4882565266903, 3999.6004395165087, 4030.2141082488633, 4030.879073627796, 10580.629677961235, 10824.458777061272, 10930.672079837459, 10940.179486538542, 10973.3964631946, 10856.78286434267, 10857.891421085846, 10874.347539147677, 10898.166476716111, 10904.400257985728, 7685.269899359552, 8036.517808931483, 8057.106579953824, 8159.796005099801, 8172.6322315495945, 5882.705864706833, 5886.85206384768, 5947.167396564398, 6081.695915204134, 6185.84535386619, 9941.850872237066, 10204.183665306906, 10221.795564088528, 10245.795084098127, 10249.74375640615, 9926.0, 10041.648542300984, 10170.033846784543, 10420.166386689198, 10495.370277783357, 6956.5478243913985, 7146.535475194096, 7397.741079062207, 7473.51422157558, 7679.692812287446, 6527.5430719849155, 6934.271901450476, 7347.5224110432655, 8298.917010830057, 8358.70744523963, 7395.7041718330665, 7500.624968751432, 7508.549487030796, 7561.924380756122, 7638.1216160140075, 7089.184743754534, 7226.89159662616, 7281.745138920112, 7304.7078116876855, 7396.112466503839, 6884.208316043719, 6912.965435172792, 6977.860442791217, 6993.475489338218, 6999.0, 4330.9133817322845, 4788.066327066189, 4839.491853355347, 4933.186024305949, 4938.43208031081, 4932.556069953722, 4960.900781984412, 5000.799968001239, 5042.042012017705, 5058.772355243949], "value": 4595.74733583056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.9920502384929, 280.2461378890785, 315.4038866542236, 316.863748588107, 317.9300553878146, 4656.371389862367, 4818.229083346665, 5101.489851014897, 5112.140334047789, 5690.004249256379, 4346.456692913386, 4861.7812198451065, 5486.43381801828, 5507.5593952483805, 5568.3596386415575, 4237.851675191377, 4252.7029256076885, 4263.252066652673, 4273.252180868351, 4282.957170428287, 3850.0, 3904.5509766376945, 3907.0, 4087.61021252774, 4282.892927676818, 4066.1664358806374, 4079.571644977279, 4088.9182216355657, 4098.385242213677, 4119.155573107506, 4086.4483294755423, 4113.087414352341, 4117.608827161415, 4126.319157339036, 4140.468026830077, 2732.822366546188, 3190.6330771961057, 3544.7873127612424, 3574.2136729919634, 3592.4252119660728, 4979.576735977446, 5301.390340110898, 5306.628536002481, 5442.510174084312, 5481.75332110056, 4641.0, 4661.951061011279, 4664.486906440289, 4670.322803193552, 4677.462091859412, 5293.068030168999, 5776.451237132465, 5798.246227990377, 5807.970960145214, 5855.0678276168765, 3074.8001379910233, 3314.8895120134785, 3477.7217822574135, 3638.1450359165574, 3808.6953043756434, 6056.910365923749, 6130.111133885606, 6139.653888630707, 6162.969185154046, 6163.229596300463, 3739.5512538495555, 3990.4261751170334, 4007.899802504961, 4018.9397159042637, 4038.51537815464, 3928.52857657083, 3970.11419575705, 4007.2586571483785, 4012.8194231259663, 4059.3910913363234, 4680.859574212779, 4685.344051832746, 4705.717656940595, 4736.739479328601, 4754.358161648133, 4986.675866068694, 5490.254872563718, 5913.319968203626, 5915.763369465173, 5930.940690593039, 1284.8201251824753, 1299.6750812296925, 1312.2979206124678, 1321.9801702974464, 1327.4557431453059, 894.6779159502574, 904.5748498205965, 921.6175736395406, 928.396542247531, 928.4475736936512, 4477.776111194427, 4694.0, 4989.251612258117, 5304.541251155963, 5356.4107948125675, 4658.697184682985, 5367.430658611979, 5819.330776960619, 5910.202122713465, 5931.73307201177, 4332.631726303236, 4724.370266423792, 5276.657017293864, 5343.545798607084, 5365.919511207257, 2375.465520257963, 2388.6178211486426, 2492.2523243027017, 2641.300055485298, 2662.134806187958, 4357.7385356878685, 4510.233260345683, 4951.455339912607, 5186.329040544123, 5221.6344855859725, 4041.7972205148267, 4199.748015119103, 4711.882202944954, 5176.948230517722, 5232.3459567554055, 4527.298268768346, 4596.897094461292, 4919.040787046635, 4927.310176575283, 5168.664036837594, 4673.696209746356, 4675.836345727883, 4818.831340903052, 4987.625928055338, 5036.395632524121, 3784.905377365588, 4240.597143271384, 4428.317239448988, 4993.950060499348, 5037.7733002014265, 4437.33439984005, 4708.034852855225, 5165.225216217447, 5173.017126745906, 5252.842414727565, 3008.879644814183, 3121.5473756304755, 3465.358908601917, 3480.3213373391945, 3497.4753786932165, 4990.7827885436745, 5005.070006044117, 5027.924581131359, 5030.0, 5142.99711556243, 4786.545278198566, 5102.540771330598, 5700.743466544099, 5783.971080144741, 5875.794347197828, 5098.97450512745, 5378.762884536501, 5847.970760146172, 5862.443067908713, 5867.031939729897, 5183.574517007853, 5417.268668729828, 5744.827655170351, 5758.884822303614, 5769.22115514417, 4945.2938736135975, 5394.595405344693, 5752.497663516384, 5865.882682346414, 5869.710812782932, 5075.670081444694, 5696.373398926197, 5733.426657334233, 5756.366799651951, 5801.970990145022], "value": 3984.5856358400374, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [627.3600927054401, 720.7801620505745, 742.6138408027829, 757.9886301705476, 815.7144999250261, 14036.368363423657, 14705.852941470583, 14743.262836858168, 14824.481143159977, 17071.14644267788, 15582.454614088509, 15595.844041559581, 15638.296276667548, 15681.451149209779, 15711.528654140366, 859.77645812089, 881.9779505512349, 882.7572417585184, 885.3669626217253, 887.8668199770021, 682.8634273145391, 713.0, 860.8923884514436, 878.9077146899548, 885.9025507194203, 916.4409710076848, 927.8422668146432, 943.259541260111, 944.7921457279422, 946.9195118414908, 928.4429342394577, 930.3952430919888, 935.873657056299, 936.929730270229, 941.9293552983554, 700.1528150937372, 702.9736584586459, 703.5391818358983, 704.6159842885588, 706.6007705646344, 15595.064296142267, 15738.685226295525, 15769.842301576951, 15864.0, 15886.04683718969, 13071.934640326832, 14252.21612811295, 14297.714045719027, 14299.57101286963, 14308.92845535776, 10962.451877406098, 11948.65042791309, 11963.461644225943, 11974.700632484171, 12190.39048047603, 3773.8867833965023, 3799.183175617228, 3853.730238883279, 3856.84572617095, 3863.5750067492554, 122350.0, 123083.76916230902, 124993.0, 126872.0, 127395.0, 10741.925807419195, 10787.784244315228, 10811.297265677706, 10871.782564348669, 11232.438378081064, 21709.56580868374, 21941.341759747233, 21984.340469785933, 22012.779872201394, 22040.88979555092, 7779.105402878741, 7782.883256751154, 7870.055593328837, 7905.604719764104, 8015.318697910627, 4366.716163449366, 4414.624756895636, 4424.955750442518, 4492.640588752892, 4542.613877820356, 3532.1346270163463, 3627.7097832173363, 3657.5976642569294, 3668.3947148720163, 3782.319182547113, 697.4106879686657, 706.3995603736782, 710.7583421636668, 723.616483263871, 726.4587882027818, 581.4098689829826, 601.7863658401204, 607.6232735703803, 627.2285089340137, 657.7040331850686, 9439.716808495756, 9465.621375144918, 9576.138147566753, 9583.281253905985, 9603.279754018477, 619.789271647633, 635.3868516881232, 642.5791106825037, 649.665422307512, 670.3865962644126, 4444.933326000112, 4644.790984405709, 4690.695104818176, 4695.460022097503, 4734.692245004133, 156533.2173339126, 160500.0, 164086.35913640712, 169237.4557880222, 171133.14433427755, 95914.52042739742, 110925.0, 119253.21120183205, 135102.0, 143134.0, 83991.0, 87775.0, 92140.6178907317, 111069.0, 115289.0, 8926.0, 9754.951225243829, 9933.65232216869, 10070.521580401304, 10185.592576296865, 36198.819005905854, 39664.61173858901, 43592.782036089615, 58838.117428237754, 61300.38699613125, 75685.86471203047, 93920.0, 98093.0, 98288.0, 100403.0, 9407.623695052122, 12680.112392132462, 12921.418536166084, 13197.472101115847, 13242.0, 14437.85562144407, 14762.63093422673, 14769.187694676895, 14789.964702470723, 15414.306356214222, 13449.932750336186, 13564.366323779244, 13636.113652612548, 13740.312984350943, 13859.168449893039, 13521.729565408834, 13785.172889626654, 13820.239886806323, 13963.232022238875, 14052.508162214273, 10581.0, 13160.868391315964, 13410.32948352559, 13434.865651343753, 13585.35085658287, 10511.26421150512, 10976.451177440937, 11200.439978000904, 11324.37715925632, 11756.823647645464, 7744.806379840549, 8603.741887743377, 10380.584776608852, 11494.885051149382, 11579.07367410622], "value": 7832.501432009096, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1582.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 118.0, 118.0, 117.0, 115.0, 174.0, 153.0, 116.0, 97.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 140.0, 125.0, 148.0, 119.0, 143.0, 145.0, 117.0, 157.0, 145.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 252.0, 197.0, 272.0, 284.0, 207.0, 271.0, 269.0, 196.0, 194.0], "value": 235.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 58.0, 85.0, 72.0, 85.0, 83.0, 81.0, 88.0, 64.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 105.0, 125.0, 80.0, 70.0, 72.0, 91.0, 71.0, 73.0, 87.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 79.0, 78.0, 116.0, 133.0, 133.0, 89.0, 86.0, 106.0, 116.0], "value": 102.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 104.0, 152.0, 91.0, 151.0, 96.0, 101.0, 96.0, 96.0, 123.0], "value": 110.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 93.0, 115.0, 116.0, 93.0, 93.0, 93.0, 90.0, 92.0, 93.0], "value": 97.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 55.0, 57.0, 57.0, 57.0, 58.0, 58.0, 55.0, 58.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 78.0, 78.0, 69.0, 67.0, 69.0, 71.0, 70.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 87.0, 95.0, 87.0, 88.0, 92.0, 91.0, 87.0, 88.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 156.0, 144.0, 140.0, 142.0, 139.0, 138.0, 138.0, 181.0, 141.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 168.0, 166.0, 174.0, 173.0, 168.0, 161.0, 220.0, 175.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 61.0, 70.0, 68.0, 69.0, 71.0, 71.0, 67.0, 68.0, 74.0], "value": 68.8, "unit": "score"}]}]} 12:18:37 INFO - Return code: 0 12:18:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:18:37 ERROR - # TBPL SUCCESS # 12:18:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:18:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:18:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:18:37 INFO - 2016-10-03 12:18:37.609 screenresolution[1960:20105] starting screenresolution argv=screenresolution get 12:18:37 INFO - 2016-10-03 12:18:37.612 screenresolution[1960:20105] Display 0: 1600x1200x32@60 12:18:37 INFO - 2016-10-03 12:18:37.618 screenresolution[1961:20108] starting screenresolution argv=screenresolution list 12:18:37 INFO - Available Modes on Display 0 12:18:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:18:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:18:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:18:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:18:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:18:37 INFO - Intel Iris: 12:18:37 INFO - Chipset Model: Intel Iris 12:18:37 INFO - Type: GPU 12:18:37 INFO - Bus: Built-In 12:18:37 INFO - VRAM (Dynamic, Max): 1536 MB 12:18:37 INFO - Vendor: Intel (0x8086) 12:18:37 INFO - Device ID: 0x0a2e 12:18:37 INFO - Revision ID: 0x0009 12:18:37 INFO - Displays: 12:18:37 INFO - Display: 12:18:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:18:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:18:37 INFO - Display Serial Number: 1600x1200 60 12:18:37 INFO - Main Display: Yes 12:18:37 INFO - Mirror: Off 12:18:37 INFO - Online: Yes 12:18:37 INFO - Rotation: Supported 12:18:37 INFO - Return code: 0 12:18:37 INFO - Running post-action listener: _resource_record_post_action 12:18:37 INFO - [mozharness: 2016-10-03 19:18:37.861313Z] Finished run-tests step (success) 12:18:37 INFO - Running post-run listener: _resource_record_post_run 12:18:37 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 774144; Write bytes: 707862528; Read time: 8; Write time: 1969 12:18:37 INFO - TinderboxPrint: CPU usage
54.5% 12:18:37 INFO - TinderboxPrint: I/O read bytes / time
774,144 / 8 12:18:37 INFO - TinderboxPrint: I/O write bytes / time
707,862,528 / 1,969 12:18:37 INFO - TinderboxPrint: CPU idle
2,205.1 (45.5%) 12:18:37 INFO - TinderboxPrint: CPU system
978.8 (20.2%) 12:18:37 INFO - TinderboxPrint: CPU user
1,657.9 (34.2%) 12:18:37 INFO - TinderboxPrint: Swap in / out
405,585,920 / 0 12:18:37 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391180800; Write bytes: 386487296; Read time: 29463; Write time: 725 12:18:37 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 774144; Write bytes: 299109376; Read time: 8; Write time: 1195 12:18:38 INFO - Running post-run listener: _upload_blobber_files 12:18:38 INFO - Blob upload gear active. 12:18:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:18:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:18:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:18:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:18:38 INFO - (blobuploader) - INFO - Open directory for files ... 12:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:39 INFO - (blobuploader) - INFO - Done attempting. 12:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:40 INFO - (blobuploader) - INFO - Done attempting. 12:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:18:42 INFO - (blobuploader) - INFO - Done attempting. 12:18:42 INFO - (blobuploader) - INFO - Iteration through files over. 12:18:42 INFO - Return code: 0 12:18:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:18:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:18:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dbeccc47ac748547be214161148ced2510b2546ea64f40f3246f7955413a52e298703baaa211bfc8a6604cd0a9a099b40d7a599790cb6a626204148f23806150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1e2b31d64c3d60ddbefea76a570579224546479df1a779fd22d1ce4ca9ab8f771d17b27292ad6b878f317c809b275fd6ffd35d0e43940daa9f89c2f9534416b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/efcd49b15a3d7a4066f63e00867fe41f8b835032d45c71d97899599d903106f8eeed152df574849cb34316e9dcf1af504fe3f62d0a78b03311d867b8c7f8ab9b"} 12:18:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:18:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:18:42 INFO - Contents: 12:18:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dbeccc47ac748547be214161148ced2510b2546ea64f40f3246f7955413a52e298703baaa211bfc8a6604cd0a9a099b40d7a599790cb6a626204148f23806150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1e2b31d64c3d60ddbefea76a570579224546479df1a779fd22d1ce4ca9ab8f771d17b27292ad6b878f317c809b275fd6ffd35d0e43940daa9f89c2f9534416b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/efcd49b15a3d7a4066f63e00867fe41f8b835032d45c71d97899599d903106f8eeed152df574849cb34316e9dcf1af504fe3f62d0a78b03311d867b8c7f8ab9b"} 12:18:42 INFO - Running post-run listener: copy_logs_to_upload_dir 12:18:42 INFO - Copying logs to upload dir... 12:18:42 INFO - mkdir: /builds/slave/test/build/upload/logs 12:18:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.978368 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-10-03 12:18:42.547050) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:42.550396) ========= 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.nNPes4ejIH/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.ssgEbTPXOx/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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/Larch/sha512/dbeccc47ac748547be214161148ced2510b2546ea64f40f3246f7955413a52e298703baaa211bfc8a6604cd0a9a099b40d7a599790cb6a626204148f23806150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1e2b31d64c3d60ddbefea76a570579224546479df1a779fd22d1ce4ca9ab8f771d17b27292ad6b878f317c809b275fd6ffd35d0e43940daa9f89c2f9534416b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/efcd49b15a3d7a4066f63e00867fe41f8b835032d45c71d97899599d903106f8eeed152df574849cb34316e9dcf1af504fe3f62d0a78b03311d867b8c7f8ab9b"} build_url:https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011004 build_url: 'https://queue.taskcluster.net/v1/task/deg3rDfMQiGuu5R9Gd3M2Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/dbeccc47ac748547be214161148ced2510b2546ea64f40f3246f7955413a52e298703baaa211bfc8a6604cd0a9a099b40d7a599790cb6a626204148f23806150", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/1e2b31d64c3d60ddbefea76a570579224546479df1a779fd22d1ce4ca9ab8f771d17b27292ad6b878f317c809b275fd6ffd35d0e43940daa9f89c2f9534416b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/efcd49b15a3d7a4066f63e00867fe41f8b835032d45c71d97899599d903106f8eeed152df574849cb34316e9dcf1af504fe3f62d0a78b03311d867b8c7f8ab9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:42.582388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:42.582717) ========= 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.nNPes4ejIH/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.ssgEbTPXOx/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/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.005369 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-03 12:18:42.631800) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 12:18:42.632129) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-03 12:18:42.632469) ========= ========= Total master_lag: 0.25 =========