builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0167 starttime: 1478169390.85 results: success (0) buildid: 20161103012823 builduid: 42affd54c8c246c3a19352b420c9d4b6 revision: ffd9870101396a9931b00939e1b8b00e19f72848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:30.846116) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:30.846546) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:30.846817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:30.871445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:30.871744) ========= 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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-11-03 03:36:30-- 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: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-11-03 03:36:31 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122219 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:31.018542) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:31.018874) ========= 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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.025590 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:31.067316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-03 03:36:31.067680) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ffd9870101396a9931b00939e1b8b00e19f72848 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ffd9870101396a9931b00939e1b8b00e19f72848 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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-11-03 03:36:31,149 truncating revision to first 12 chars 2016-11-03 03:36:31,149 Setting DEBUG logging. 2016-11-03 03:36:31,149 attempt 1/10 2016-11-03 03:36:31,149 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ffd987010139?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-03 03:36:33,216 unpacking tar archive at: mozilla-aurora-ffd987010139/testing/mozharness/ program finished with exit code 0 elapsedTime=2.329538 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-03 03:36:33.424574) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:33.424919) ========= script_repo_revision: ffd9870101396a9931b00939e1b8b00e19f72848 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:33.425316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:33.425602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-03 03:36:33.443111) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-03 03:36:33.443505) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:36:33 INFO - MultiFileLogger online at 20161103 03:36:33 in /builds/slave/test 03:36:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:36:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:36:33 INFO - {'append_to_log': False, 03:36:33 INFO - 'base_work_dir': '/builds/slave/test', 03:36:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:36:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:36:33 INFO - 'branch': 'Mozilla-Aurora', 03:36:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:36:33 INFO - 'config_files': ('talos/mac_config.py',), 03:36:33 INFO - 'default_actions': ('clobber', 03:36:33 INFO - 'read-buildbot-config', 03:36:33 INFO - 'download-and-extract', 03:36:33 INFO - 'populate-webroot', 03:36:33 INFO - 'create-virtualenv', 03:36:33 INFO - 'install', 03:36:33 INFO - 'run-tests'), 03:36:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:36:33 INFO - 'download_minidump_stackwalk': True, 03:36:33 INFO - 'download_symbols': 'ondemand', 03:36:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:36:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:36:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:36:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:36:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:36:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:36:33 INFO - 'installer_path': 'installer.exe', 03:36:33 INFO - 'log_level': 'info', 03:36:33 INFO - 'log_name': 'talos', 03:36:33 INFO - 'log_to_console': True, 03:36:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:36:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:36:33 INFO - 'opt_config_files': (), 03:36:33 INFO - 'pip_index': False, 03:36:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:33 INFO - 'cmd': ('bash', 03:36:33 INFO - '-c', 03:36:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:33 INFO - 'enabled': True, 03:36:33 INFO - 'halt_on_failure': False, 03:36:33 INFO - 'name': 'check_screen_resolution'},), 03:36:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:36:33 INFO - 'cmd': ('bash', 03:36:33 INFO - '-c', 03:36:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:36:33 INFO - 'enabled': True, 03:36:33 INFO - 'halt_on_failure': False, 03:36:33 INFO - 'name': 'check_screen_resolution'},), 03:36:33 INFO - 'run_cmd_checks_enabled': True, 03:36:33 INFO - 'sps_profile': False, 03:36:33 INFO - 'sps_profile_interval': 0, 03:36:33 INFO - 'suite': 'dromaeojs-e10s', 03:36:33 INFO - 'system_bits': '32', 03:36:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:36:33 INFO - 'title': 't-yosemite-r7-0167', 03:36:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:36:33 INFO - 'use_talos_json': True, 03:36:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:36:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:36:33 INFO - 'work_dir': 'build'} 03:36:33 INFO - [mozharness: 2016-11-03 10:36:33.646164Z] Running clobber step. 03:36:33 INFO - Running pre-action listener: _resource_record_pre_action 03:36:33 INFO - Running main action method: clobber 03:36:33 INFO - rmtree: /builds/slave/test/build 03:36:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:36:36 INFO - Running post-action listener: _resource_record_post_action 03:36:36 INFO - [mozharness: 2016-11-03 10:36:36.003671Z] Finished clobber step (success) 03:36:36 INFO - [mozharness: 2016-11-03 10:36:36.003846Z] Running read-buildbot-config step. 03:36:36 INFO - Running pre-action listener: _resource_record_pre_action 03:36:36 INFO - Running main action method: read_buildbot_config 03:36:36 INFO - Using buildbot properties: 03:36:36 INFO - { 03:36:36 INFO - "project": "", 03:36:36 INFO - "product": "firefox", 03:36:36 INFO - "script_repo_revision": "production", 03:36:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:36:36 INFO - "repository": "", 03:36:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:36:36 INFO - "buildid": "20161103012823", 03:36:36 INFO - "pgo_build": "False", 03:36:36 INFO - "basedir": "/builds/slave/test", 03:36:36 INFO - "buildnumber": 147, 03:36:36 INFO - "slavename": "t-yosemite-r7-0167", 03:36:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 03:36:36 INFO - "platform": "yosemite_r7", 03:36:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:36:36 INFO - "branch": "mozilla-aurora", 03:36:36 INFO - "repo_path": "releases/mozilla-aurora", 03:36:36 INFO - "revision": "ffd9870101396a9931b00939e1b8b00e19f72848", 03:36:36 INFO - "stage_platform": "macosx64", 03:36:36 INFO - "builduid": "42affd54c8c246c3a19352b420c9d4b6", 03:36:36 INFO - "slavebuilddir": "test" 03:36:36 INFO - } 03:36:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 03:36:36 INFO - Running post-action listener: _resource_record_post_action 03:36:36 INFO - [mozharness: 2016-11-03 10:36:36.006846Z] Finished read-buildbot-config step (success) 03:36:36 INFO - [mozharness: 2016-11-03 10:36:36.006949Z] Running download-and-extract step. 03:36:36 INFO - Running pre-action listener: _resource_record_pre_action 03:36:36 INFO - Running main action method: download_and_extract 03:36:36 INFO - mkdir: /builds/slave/test/build/tests 03:36:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:36 INFO - trying https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 03:36:36 INFO - Downloading https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:36:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 03:36:37 INFO - Downloaded 1199 bytes. 03:36:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 03:36:37 INFO - Using the following test package requirements: 03:36:37 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:36:37 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 03:36:37 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 03:36:37 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'jsshell-mac.zip'], 03:36:37 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 03:36:37 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 03:36:37 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 03:36:37 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 03:36:37 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 03:36:37 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 03:36:37 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 03:36:37 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:36:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:36:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:36:37 INFO - Fetch https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:36:37 INFO - Expected file size: 16421429 03:36:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 03:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 03:36:45 INFO - Expected file size: 16421429 03:36:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 03:36:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:36:52 INFO - Fetch https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 03:36:53 INFO - Expected file size: 14414089 03:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:53 INFO - trying https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 03:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 03:36:56 INFO - Downloaded 115460562 bytes. 03:36:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:36:56 INFO - mkdir: /builds/slave/test/properties 03:36:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:56 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:56 INFO - Contents: 03:36:56 INFO - build_url:https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 03:36:57 INFO - Running post-action listener: _resource_record_post_action 03:36:57 INFO - Running post-action listener: set_extra_try_arguments 03:36:57 INFO - [mozharness: 2016-11-03 10:36:57.285030Z] Finished download-and-extract step (success) 03:36:57 INFO - [mozharness: 2016-11-03 10:36:57.285169Z] Running populate-webroot step. 03:36:57 INFO - Running pre-action listener: _resource_record_pre_action 03:36:57 INFO - Running main action method: populate_webroot 03:36:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:36:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:36:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:36:57 INFO - '--tppagecycles', 03:36:57 INFO - '7'], 03:36:57 INFO - 'tests': ['tsvgm']}}, 03:36:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:36:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:36:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['damp', 'tps']}, 03:36:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'tests': ['damp', 'tps']}, 03:36:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['dromaeo_dom']}, 03:36:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['basic_compositor_video']}, 03:36:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:36:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['a11yr', 03:36:57 INFO - 'ts_paint', 03:36:57 INFO - 'tpaint', 03:36:57 INFO - 'sessionrestore', 03:36:57 INFO - 'sessionrestore_no_auto_restore', 03:36:57 INFO - 'tabpaint']}, 03:36:57 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:57 INFO - 'ts_paint', 03:36:57 INFO - 'tpaint', 03:36:57 INFO - 'sessionrestore', 03:36:57 INFO - 'sessionrestore_no_auto_restore', 03:36:57 INFO - 'tabpaint']}, 03:36:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:36:57 INFO - 'ts_paint', 03:36:57 INFO - 'tpaint', 03:36:57 INFO - 'sessionrestore', 03:36:57 INFO - 'sessionrestore_no_auto_restore', 03:36:57 INFO - 'tabpaint']}, 03:36:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:36:57 INFO - 'ts_paint', 03:36:57 INFO - 'tpaint', 03:36:57 INFO - 'sessionrestore', 03:36:57 INFO - 'sessionrestore_no_auto_restore', 03:36:57 INFO - 'tabpaint']}, 03:36:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['a11yr', 03:36:57 INFO - 'ts_paint', 03:36:57 INFO - 'tpaint', 03:36:57 INFO - 'sessionrestore', 03:36:57 INFO - 'sessionrestore_no_auto_restore', 03:36:57 INFO - 'tabpaint']}, 03:36:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['a11yr', 03:36:57 INFO - 'ts_paint', 03:36:57 INFO - 'tpaint', 03:36:57 INFO - 'sessionrestore', 03:36:57 INFO - 'sessionrestore_no_auto_restore', 03:36:57 INFO - 'tabpaint']}, 03:36:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['tsvgx', 03:36:57 INFO - 'tsvgr_opacity', 03:36:57 INFO - 'tart', 03:36:57 INFO - 'tscrollx', 03:36:57 INFO - 'cart']}, 03:36:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:57 INFO - 'tsvgr_opacity', 03:36:57 INFO - 'tart', 03:36:57 INFO - 'tscrollx', 03:36:57 INFO - 'cart']}, 03:36:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'talos_options': ['--disable-e10s'], 03:36:57 INFO - 'tests': ['tp5o']}, 03:36:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'tests': ['tp5o']}, 03:36:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'talos_options': ['--disable-e10s', 03:36:57 INFO - '--xperf_path', 03:36:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:57 INFO - 'tests': ['tp5n']}, 03:36:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:36:57 INFO - 'talos_options': ['--xperf_path', 03:36:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:57 INFO - 'tests': ['tp5n']}}, 03:36:57 INFO - 'talos.zip': {'path': '', 03:36:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:36:57 INFO - Running post-action listener: _resource_record_post_action 03:36:57 INFO - [mozharness: 2016-11-03 10:36:57.303295Z] Finished populate-webroot step (success) 03:36:57 INFO - [mozharness: 2016-11-03 10:36:57.303437Z] Running create-virtualenv step. 03:36:57 INFO - Running pre-action listener: _resource_record_pre_action 03:36:57 INFO - Running main action method: create_virtualenv 03:36:57 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:57 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 03:36:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:57 INFO - Using real prefix '/tools/python27' 03:36:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:58 INFO - Installing distribute.............................................................................................................................................................................................done. 03:37:01 INFO - Installing pip.................done. 03:37:01 INFO - Return code: 0 03:37:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37:01 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 03:37:01 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 03:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:01 INFO - 'HOME': '/Users/cltbld', 03:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:01 INFO - 'LOGNAME': 'cltbld', 03:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:01 INFO - 'MOZ_NO_REMOTE': '1', 03:37:01 INFO - 'NO_EM_RESTART': '1', 03:37:01 INFO - 'PAGER': '/bin/cat', 03:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:01 INFO - 'PWD': '/builds/slave/test', 03:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:01 INFO - 'SHELL': '/bin/bash', 03:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:01 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:01 INFO - 'USER': 'cltbld', 03:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:01 INFO - 'XPC_FLAGS': '0x0', 03:37:01 INFO - 'XPC_SERVICE_NAME': '0', 03:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:01 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 03:37:01 INFO - Cleaning up... 03:37:01 INFO - Return code: 0 03:37:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:01 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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37:01 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 03:37:01 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 03:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:01 INFO - 'HOME': '/Users/cltbld', 03:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:01 INFO - 'LOGNAME': 'cltbld', 03:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:01 INFO - 'MOZ_NO_REMOTE': '1', 03:37:01 INFO - 'NO_EM_RESTART': '1', 03:37:01 INFO - 'PAGER': '/bin/cat', 03:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:01 INFO - 'PWD': '/builds/slave/test', 03:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:01 INFO - 'SHELL': '/bin/bash', 03:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:01 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:01 INFO - 'USER': 'cltbld', 03:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:01 INFO - 'XPC_FLAGS': '0x0', 03:37:01 INFO - 'XPC_SERVICE_NAME': '0', 03:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:01 INFO - Downloading/unpacking psutil>=3.1.1 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:01 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 03:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:37:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:04 INFO - Installing collected packages: psutil 03:37:04 INFO - Running setup.py install for psutil 03:37:04 INFO - building 'psutil._psutil_osx' extension 03:37: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 03:37: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 03:37: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 03:37:05 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 03:37:05 INFO - building 'psutil._psutil_posix' extension 03:37:05 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 03:37:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:37:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:37:05 INFO - ^ 03:37:05 INFO - 1 warning generated. 03:37: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 03:37:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:37:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:37:05 INFO - Successfully installed psutil 03:37:05 INFO - Cleaning up... 03:37:05 INFO - Return code: 0 03:37:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37: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 03:37: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 03:37:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:05 INFO - 'HOME': '/Users/cltbld', 03:37:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:05 INFO - 'LOGNAME': 'cltbld', 03:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:05 INFO - 'MOZ_NO_REMOTE': '1', 03:37:05 INFO - 'NO_EM_RESTART': '1', 03:37:05 INFO - 'PAGER': '/bin/cat', 03:37:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:05 INFO - 'PWD': '/builds/slave/test', 03:37:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:05 INFO - 'SHELL': '/bin/bash', 03:37:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:05 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:05 INFO - 'USER': 'cltbld', 03:37:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:05 INFO - 'XPC_FLAGS': '0x0', 03:37:05 INFO - 'XPC_SERVICE_NAME': '0', 03:37:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:37:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:37:08 INFO - Installing collected packages: mozsystemmonitor 03:37:08 INFO - Running setup.py install for mozsystemmonitor 03:37:08 INFO - Successfully installed mozsystemmonitor 03:37:08 INFO - Cleaning up... 03:37:08 INFO - Return code: 0 03:37:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37: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 03:37: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 03:37:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:08 INFO - 'HOME': '/Users/cltbld', 03:37:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:08 INFO - 'LOGNAME': 'cltbld', 03:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:08 INFO - 'MOZ_NO_REMOTE': '1', 03:37:08 INFO - 'NO_EM_RESTART': '1', 03:37:08 INFO - 'PAGER': '/bin/cat', 03:37:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:08 INFO - 'PWD': '/builds/slave/test', 03:37:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:08 INFO - 'SHELL': '/bin/bash', 03:37:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:08 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:08 INFO - 'USER': 'cltbld', 03:37:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:08 INFO - 'XPC_FLAGS': '0x0', 03:37:08 INFO - 'XPC_SERVICE_NAME': '0', 03:37:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:08 INFO - Downloading/unpacking jsonschema==2.5.1 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:37:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 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 03:37:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:37:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:37:11 INFO - warning: no files found matching '*.txt' 03:37:11 INFO - no previously-included directories found matching 'build' 03:37:11 INFO - no previously-included directories found matching 'dist' 03:37:11 INFO - no previously-included directories found matching '.git*' 03:37:11 INFO - Installing collected packages: jsonschema, functools32 03:37:11 INFO - Running setup.py install for functools32 03:37:12 INFO - warning: no files found matching '*.txt' 03:37:12 INFO - no previously-included directories found matching 'build' 03:37:12 INFO - no previously-included directories found matching 'dist' 03:37:12 INFO - no previously-included directories found matching '.git*' 03:37:12 INFO - Successfully installed jsonschema functools32 03:37:12 INFO - Cleaning up... 03:37:12 INFO - Return code: 0 03:37:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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', '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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:37: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 functools32==3.2.3-2 03:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:12 INFO - 'HOME': '/Users/cltbld', 03:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:12 INFO - 'LOGNAME': 'cltbld', 03:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:12 INFO - 'MOZ_NO_REMOTE': '1', 03:37:12 INFO - 'NO_EM_RESTART': '1', 03:37:12 INFO - 'PAGER': '/bin/cat', 03:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:12 INFO - 'PWD': '/builds/slave/test', 03:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:12 INFO - 'SHELL': '/bin/bash', 03:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:12 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:12 INFO - 'USER': 'cltbld', 03:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:12 INFO - 'XPC_FLAGS': '0x0', 03:37:12 INFO - 'XPC_SERVICE_NAME': '0', 03:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:37:12 INFO - Cleaning up... 03:37:12 INFO - Return code: 0 03:37:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37: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 03:37: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 03:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:12 INFO - 'HOME': '/Users/cltbld', 03:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:12 INFO - 'LOGNAME': 'cltbld', 03:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:12 INFO - 'MOZ_NO_REMOTE': '1', 03:37:12 INFO - 'NO_EM_RESTART': '1', 03:37:12 INFO - 'PAGER': '/bin/cat', 03:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:12 INFO - 'PWD': '/builds/slave/test', 03:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:12 INFO - 'SHELL': '/bin/bash', 03:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:12 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:12 INFO - 'USER': 'cltbld', 03:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:12 INFO - 'XPC_FLAGS': '0x0', 03:37:12 INFO - 'XPC_SERVICE_NAME': '0', 03:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:15 INFO - Downloading blobuploader-1.2.4.tar.gz 03:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:37:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:37:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37: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 03:37:16 INFO - Downloading docopt-0.6.1.tar.gz 03:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:37:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:37:16 INFO - Running setup.py install for blobuploader 03:37:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:37:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:37:16 INFO - Running setup.py install for requests 03:37:17 INFO - Running setup.py install for docopt 03:37:17 INFO - Successfully installed blobuploader requests docopt 03:37:17 INFO - Cleaning up... 03:37:17 INFO - Return code: 0 03:37:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:17 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')]} 03:37:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:17 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')]} 03:37:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:17 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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37:17 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 03:37:17 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 03:37:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:17 INFO - 'HOME': '/Users/cltbld', 03:37:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:17 INFO - 'LOGNAME': 'cltbld', 03:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:17 INFO - 'MOZ_NO_REMOTE': '1', 03:37:17 INFO - 'NO_EM_RESTART': '1', 03:37:17 INFO - 'PAGER': '/bin/cat', 03:37:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:17 INFO - 'PWD': '/builds/slave/test', 03:37:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:17 INFO - 'SHELL': '/bin/bash', 03:37:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:17 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:17 INFO - 'USER': 'cltbld', 03:37:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:17 INFO - 'XPC_FLAGS': '0x0', 03:37:17 INFO - 'XPC_SERVICE_NAME': '0', 03:37:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:17 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-hVHkHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:17 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-RojQ1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:17 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ogm9Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:17 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ZcP8xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0xuoD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9JtlHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-YJA0z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-PF99o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-BkVTuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-oo32WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-f8DQEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Kzz8Sx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:18 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ri_Uct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:19 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-v8JXox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:19 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-AC7kq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:19 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-QMF3st-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:19 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-hLRLcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:37:19 INFO - Running setup.py install for manifestparser 03:37:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:37:19 INFO - Running setup.py install for mozcrash 03:37:19 INFO - Running setup.py install for mozdebug 03:37:19 INFO - Running setup.py install for mozdevice 03:37:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Running setup.py install for mozfile 03:37:20 INFO - Running setup.py install for mozhttpd 03:37:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Running setup.py install for mozinfo 03:37:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Running setup.py install for mozInstall 03:37:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Running setup.py install for mozleak 03:37:20 INFO - Running setup.py install for mozlog 03:37:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:37:20 INFO - Running setup.py install for moznetwork 03:37:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:37:21 INFO - Running setup.py install for mozprocess 03:37:21 INFO - Running setup.py install for mozprofile 03:37:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:37:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:37:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:37:21 INFO - Running setup.py install for mozrunner 03:37:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:37:21 INFO - Running setup.py install for mozscreenshot 03:37:21 INFO - Running setup.py install for moztest 03:37:21 INFO - Running setup.py install for mozversion 03:37:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:37:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:37:22 INFO - Cleaning up... 03:37:22 INFO - Return code: 0 03:37:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37:22 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')]} 03:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:22 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')]} 03:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:22 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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37:22 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 03:37:22 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 03:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:22 INFO - 'HOME': '/Users/cltbld', 03:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:22 INFO - 'LOGNAME': 'cltbld', 03:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:22 INFO - 'MOZ_NO_REMOTE': '1', 03:37:22 INFO - 'NO_EM_RESTART': '1', 03:37:22 INFO - 'PAGER': '/bin/cat', 03:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:22 INFO - 'PWD': '/builds/slave/test', 03:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:22 INFO - 'SHELL': '/bin/bash', 03:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:22 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:22 INFO - 'USER': 'cltbld', 03:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:22 INFO - 'XPC_FLAGS': '0x0', 03:37:22 INFO - 'XPC_SERVICE_NAME': '0', 03:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:37:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ihjg8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:37:22 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)) 03:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:37:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-punPdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:37: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)) 03:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:37:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-0VCpgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:37: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)) 03:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:37:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-qtQV0z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:37: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)) 03:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:37:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-PGE4oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:37: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)) 03:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:37:22 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-HWkYjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:37:23 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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-3CHGFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:37:23 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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-9E_jPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:37:23 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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-m_Luxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:37:23 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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-SfsahV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:37:23 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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Qqdlfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:37: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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-2GP_Fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:37: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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-6TbH2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:37: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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-qFgSgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:37: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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-uSJN5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:37: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)) 03:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:37:23 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-Ztc7UR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:37:24 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)) 03:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:37:24 INFO - Running setup.py (path:/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/pip-ncedwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:37:24 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)) 03:37:24 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)) 03:37:24 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)) 03:37:24 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)) 03:37:24 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)) 03:37:24 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)) 03:37:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:37:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:37:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:37:26 INFO - Downloading blessings-1.6.tar.gz 03:37:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:37:26 INFO - Installing collected packages: blessings 03:37:26 INFO - Running setup.py install for blessings 03:37:26 INFO - Successfully installed blessings 03:37:26 INFO - Cleaning up... 03:37:27 INFO - Return code: 0 03:37:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:37:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:27 INFO - Reading from file tmpfile_stdout 03:37:27 INFO - Current package versions: 03:37:27 INFO - blessings == 1.6 03:37:27 INFO - blobuploader == 1.2.4 03:37:27 INFO - docopt == 0.6.1 03:37:27 INFO - functools32 == 3.2.3-2 03:37:27 INFO - jsonschema == 2.5.1 03:37:27 INFO - manifestparser == 1.1 03:37:27 INFO - mozInstall == 1.12 03:37:27 INFO - mozcrash == 0.17 03:37:27 INFO - mozdebug == 0.1 03:37:27 INFO - mozdevice == 0.48 03:37:27 INFO - mozfile == 1.2 03:37:27 INFO - mozhttpd == 0.7 03:37:27 INFO - mozinfo == 0.9 03:37:27 INFO - mozleak == 0.1 03:37:27 INFO - mozlog == 3.4 03:37:27 INFO - moznetwork == 0.27 03:37:27 INFO - mozprocess == 0.23 03:37:27 INFO - mozprofile == 0.28 03:37:27 INFO - mozrunner == 6.12 03:37:27 INFO - mozscreenshot == 0.1 03:37:27 INFO - mozsystemmonitor == 0.3 03:37:27 INFO - moztest == 0.7 03:37:27 INFO - mozversion == 1.4 03:37:27 INFO - psutil == 3.1.1 03:37:27 INFO - requests == 1.2.3 03:37:27 INFO - wsgiref == 0.1.2 03:37:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37:27 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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37:27 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 03:37:27 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 03:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:27 INFO - 'HOME': '/Users/cltbld', 03:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:27 INFO - 'LOGNAME': 'cltbld', 03:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:27 INFO - 'MOZ_NO_REMOTE': '1', 03:37:27 INFO - 'NO_EM_RESTART': '1', 03:37:27 INFO - 'PAGER': '/bin/cat', 03:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:27 INFO - 'PWD': '/builds/slave/test', 03:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:27 INFO - 'SHELL': '/bin/bash', 03:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:27 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:27 INFO - 'USER': 'cltbld', 03:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:27 INFO - 'XPC_FLAGS': '0x0', 03:37:27 INFO - 'XPC_SERVICE_NAME': '0', 03:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37: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)) 03:37:27 INFO - Cleaning up... 03:37:27 INFO - Return code: 0 03:37:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:37: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')]} 03:37:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:37:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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')]} 03:37:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:37:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:37: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 0x10b146490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b0bc570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee2a600320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, '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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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 03:37: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 03:37: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 03:37:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:37:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:37:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:37:27 INFO - 'HOME': '/Users/cltbld', 03:37:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:37:27 INFO - 'LOGNAME': 'cltbld', 03:37:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:27 INFO - 'MOZ_NO_REMOTE': '1', 03:37:27 INFO - 'NO_EM_RESTART': '1', 03:37:27 INFO - 'PAGER': '/bin/cat', 03:37:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:37:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:27 INFO - 'PWD': '/builds/slave/test', 03:37:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:37:27 INFO - 'SHELL': '/bin/bash', 03:37:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:37:27 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:37:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:37:27 INFO - 'USER': 'cltbld', 03:37:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:37:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:37:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:27 INFO - 'XPC_FLAGS': '0x0', 03:37:27 INFO - 'XPC_SERVICE_NAME': '0', 03:37:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:37:28 INFO - Cleaning up... 03:37:28 INFO - Return code: 0 03:37:28 INFO - Running post-action listener: _resource_record_post_action 03:37:28 INFO - Running post-action listener: _start_resource_monitoring 03:37:28 INFO - Starting resource monitoring. 03:37:28 INFO - [mozharness: 2016-11-03 10:37:28.232200Z] Finished create-virtualenv step (success) 03:37:28 INFO - [mozharness: 2016-11-03 10:37:28.233061Z] Running install step. 03:37:28 INFO - Running pre-action listener: _resource_record_pre_action 03:37:28 INFO - Running main action method: install 03:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:37:28 INFO - Reading from file tmpfile_stdout 03:37:28 INFO - Detecting whether we're running mozinstall >=1.0... 03:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:37:28 INFO - Reading from file tmpfile_stdout 03:37:28 INFO - Output received: 03:37:28 INFO - Usage: mozinstall [options] installer 03:37:28 INFO - Options: 03:37:28 INFO - -h, --help show this help message and exit 03:37:28 INFO - -d DEST, --destination=DEST 03:37:28 INFO - Directory to install application into. [default: 03:37:28 INFO - "/builds/slave/test"] 03:37:28 INFO - --app=APP Application being installed. [default: firefox] 03:37:28 INFO - mkdir: /builds/slave/test/build/application 03:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:38:00 INFO - Reading from file tmpfile_stdout 03:38:00 INFO - Output received: 03:38:00 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:38:00 INFO - Running post-action listener: _resource_record_post_action 03:38:00 INFO - [mozharness: 2016-11-03 10:38:00.726017Z] Finished install step (success) 03:38:00 INFO - [mozharness: 2016-11-03 10:38:00.726163Z] Running run-tests step. 03:38:00 INFO - Running pre-action listener: _resource_record_pre_action 03:38:00 INFO - Running main action method: run_tests 03:38:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:38:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:38:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:38:00 INFO - 2016-11-03 03:38:00.740 screenresolution[1658:7584] starting screenresolution argv=screenresolution get 03:38:00 INFO - 2016-11-03 03:38:00.743 screenresolution[1658:7584] Display 0: 1600x1200x32@60 03:38:00 INFO - 2016-11-03 03:38:00.749 screenresolution[1659:7586] starting screenresolution argv=screenresolution list 03:38:00 INFO - Available Modes on Display 0 03:38:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:38:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:38:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:38:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:38:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:38:00 INFO - Intel Iris: 03:38:00 INFO - Chipset Model: Intel Iris 03:38:00 INFO - Type: GPU 03:38:00 INFO - Bus: Built-In 03:38:00 INFO - VRAM (Dynamic, Max): 1536 MB 03:38:00 INFO - Vendor: Intel (0x8086) 03:38:00 INFO - Device ID: 0x0a2e 03:38:00 INFO - Revision ID: 0x0009 03:38:00 INFO - Displays: 03:38:00 INFO - Display: 03:38:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:38:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:38:00 INFO - Display Serial Number: 1600x1200 60 03:38:00 INFO - Main Display: Yes 03:38:00 INFO - Mirror: Off 03:38:00 INFO - Online: Yes 03:38:00 INFO - Rotation: Supported 03:38:00 INFO - Return code: 0 03:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:38:00 INFO - Python 2.7.3 03:38:00 INFO - Return code: 0 03:38:00 INFO - grabbing minidump binary from tooltool 03:38: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')]} 03:38:00 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 0x10af5ad30>, '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 0x10adc0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af52b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:38:00 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 03:38:00 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 03:38:00 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 03:38:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:38:01 INFO - Return code: 0 03:38:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:38:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:38:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:38:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:38:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 03:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0167 --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 03:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4nAU0aiQCJ/Render', 03:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:38:01 INFO - 'HOME': '/Users/cltbld', 03:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:38:01 INFO - 'LOGNAME': 'cltbld', 03:38:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:38:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:38:01 INFO - 'MOZ_NO_REMOTE': '1', 03:38:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:38:01 INFO - 'NO_EM_RESTART': '1', 03:38:01 INFO - 'PAGER': '/bin/cat', 03:38:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:38:01 INFO - 'PWD': '/builds/slave/test', 03:38:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:38:01 INFO - 'SHELL': '/bin/bash', 03:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.wtKViBHvdJ/Listeners', 03:38:01 INFO - 'TMPDIR': '/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/', 03:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:38:01 INFO - 'USER': 'cltbld', 03:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:38:01 INFO - 'XPC_FLAGS': '0x0', 03:38:01 INFO - 'XPC_SERVICE_NAME': '0', 03:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:38:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0167', '--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 03:38:01 INFO - mozversion application_buildid: 20161103012823 03:38:01 INFO - mozversion application_changeset: ffd9870101396a9931b00939e1b8b00e19f72848 03:38:01 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:38:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:38:01 INFO - mozversion application_name: Firefox 03:38:01 INFO - mozversion application_remotingname: firefox-dev 03:38:01 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:01 INFO - mozversion application_vendor: Mozilla 03:38:01 INFO - mozversion application_version: 51.0a2 03:38:01 INFO - mozversion platform_buildid: 20161103012823 03:38:01 INFO - mozversion platform_changeset: ffd9870101396a9931b00939e1b8b00e19f72848 03:38:01 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:38:01 INFO - mozversion platform_version: 51.0a2 03:38:01 INFO - using testdate: 1478169481 03:38:01 INFO - actual date: 1478169481 03:38:01 INFO - starting webserver on 'localhost:49280' 03:38:01 INFO - SUITE-START | Running 2 tests 03:38:01 INFO - TEST-START | dromaeo_css 03:38:01 INFO - operating with platform_type : mac_ 03:38:01 INFO - Initialising browser for dromaeo_css test... 03:38:01 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpYABeLF/profile http://localhost:49280/getInfo.html) 03:38:04 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 03:38:04 INFO - PROCESS | 1669 | colorDepth:24 03:38:04 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 03:38:04 INFO - PROCESS | 1669 | __metrics 03:38:04 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:38:05 INFO - TEST-INFO | 1669: exit 0 03:38:05 INFO - Browser initialized. 03:38:05 INFO - Running cycle 1/1 for dromaeo_css test... 03:38:05 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpYABeLF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:38:17 INFO - PROCESS | 1675 | RSS: Main: 225665024 03:38:17 INFO - PROCESS | 1675 | 03:39:06 INFO - PROCESS | 1675 | 1478169546871 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] 03:41:19 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 03:41:20 INFO - PROCESS | 1675 | RSS: Main: 238505984 03:41:20 INFO - PROCESS | 1675 | 03:44:23 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 03:44:23 INFO - PROCESS | 1675 | RSS: Main: 248008704 03:44:23 INFO - PROCESS | 1675 | 03:47:25 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 03:47:26 INFO - PROCESS | 1675 | RSS: Main: 251138048 03:47:26 INFO - PROCESS | 1675 | 03:50:27 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 03:50:28 INFO - PROCESS | 1675 | RSS: Main: 251367424 03:50:28 INFO - PROCESS | 1675 | 03:53:31 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 03:53:32 INFO - PROCESS | 1675 | RSS: Main: 255893504 03:53:32 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 03:56:34 INFO - PROCESS | 1675 | RSS: Main: 258723840 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | __start_tp_report 03:56:34 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 03:56:34 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 03:56:34 INFO - PROCESS | 1675 | |i|pagename|runs| 03:56:34 INFO - PROCESS | 1675 | |0;dojo.html;3418.094205035666;3426.8457919393627;3456.032310952933;3457.3431048100874;3484.2334686369004;4325.913481730364;4758.571728544431;5191.117510023296;5663.716814159291;5974.3428222895445;4580.770961451923;5652.547796176306;5891.145783861348;5938.1389698493695;6015.428534289235;4317.503487098977;5312.4687531246955;5423.322084739408;5426.728663566825;5454.045542030149;4274.465691788527;4704.176769065417;5149.81975630853;5402.135658294674;5434.347878254615;4269.6370808481315;4434.246178149722;5301.761420736057;5429;5444.373897001836;4607.17070927233;5311.176767601028;5360.865978350534;5366.570674346043;5378.327709036371;5284.81503147388;5330.253764472977;5334.973325133388;5412;5412.3505179378335;4819.807207711688;5848.97075514624;6013.729382177812;6042.607230530001;6113.510919126459;6238.781642642532;6294.464970477515;6306.49548036156;6320.841978950517;6322.71547780351;6344.429001389897;6356.682165891687;6366.745330186787;6372.171617689717;6377.394147555975;5868.383819698955;5949.0481522956115;6004.489618382399;6057.697115144225;6070.726817293233;5474.781008759605;6429.099926010363;6434.549581529248;6449.064885591657;6451.677416129175;5144.38267407906;6275.435210831047;6284.717187726564;6304.432601065926;6310.810675679737;6180.072989051589;6191.9690401547705;6205.689715514206;6211.037289220088;6280.05799130125;5242.68543887368;6224.62652240867;6250.3749625037135;6296.464800492009;6307.810765676945;6211.720472578745;6246.75739314364;6261.060840873905;6277.403646653561;6307;4895.4370247422;4954.256861470808;4984.8753781155765;4989.775460104304;5027.748612569357;4488.932666010012;4504.954950450519;4555.703879247838;4563.657725670588;4608.055348653518;6020.819375418744;6099.207103076572;6111.786087486917;6116.3577824328695;6121.540884433685;6210.285817130997;6217.937820621736;6264.686765661699;6326.114343991845;6350.809475715736;6064.241969753781;6136.610985192662;6138.602983404986;6139.522803442411;6144.941444616014;5496.972515137399;5525.364583072998;5552.028395030934;5556.499915007588;5564;6203.2556093269095;6257.030160325156;6487.643179625072;6492.5455218134275;6505.2844187138435;5404.72976351173;5439.5104440600535;6098.32918378969;6314.6842657866;6321.810345689637;5352.4915133062295;6458.580192287486;6461.418472337512;6477;6480.416762491398;6137.079438084323;6309.432151106423;6331.430171284606;6333.20834895638;6347.587406818727;5365.731713414391;5435.782568697208;6235.220597425322;6255.906161407492;6317.305096439296;5553.972230138824;5879.882402351844;6245.906311405423;6285.528585356208;6286.214223222098;6215.378462153749;6236.844078898064;6264.74941002373;6270.968645156745;6284.24589049317;5013.774380152829;5935.940640593712;5984.16221728967;6099.207103076572;6106.961816491296;6205.968970155121;6229.937700623117;6253.781117661042;6257.2804127525915;6262;6156.476699480415;6161.322254552086;6182.103594978613;6183.196184495987;6195.535334849814 03:56:34 INFO - PROCESS | 1675 | |1;ext.html;489.4273699771268;518.6602775182253;530.5119290252969;533.9839804805856;539.9406065332813;30828;40468.1906361873;40531;40591.79704101483;40627.59372406279;36219;41254;41711.374329385006;41754.791226043904;41826.908654567305;9537.713868583936;9696;9696.563654635558;9698.563564639573;9722.611095556205;9729.173020293283;9759.316847820655;9830.311878168532;9850.605975760996;9864.013598640115;9817;9852.359596626233;9855.901440985606;9860.260480463958;9860.852087218698;9756.658516951908;9798.755031124243;9825.557849896772;9825.901740982641;9839.360441571274;9479.810403791886;9567.186789122932;9583.329166958316;9583.760405989837;9604.66383676568;40389.79805100985;40460.79769601163;40557.39163912544;40635;40732.98167545835;3230.9030729078167;3511.8244087795506;3744.5319335083113;3860.3823388257742;4057.3305404608204;30040.54939175914;30110.548341774673;30779.230519236975;30901.072967811;31672;2664.307280107186;2730.699623041464;3190.5214217867274;3259.022293312021;3262.5269335946155;520763.39618302044;527974;528858;529938;533635;58118;58226;58359;58513;58553;34170.82914585461;34509.48235776465;34586.82706586451;35775.82112089423;59713;17067.97592144475;17180.312787488612;17185.91407042982;17198.65602687939;17209.7418538722;12962.28707421082;13036.674083147996;13042.282674452807;13060.085793994329;13088.738225235633;18893.338733144275;18968.620627587647;18993.240270389306;19098.949557774176;19147.946862922396;6878.415334696607;7853.136155022943;7926.841463170705;8011.879821802678;8068.8386232275025;839.2404873589411;846.3187134356779;866.991330086691;908.8911527935908;960.4573416019927;23658.4085397863;26106.608400874004;28009.299767505974;28481.28796780097;30654.54018189729;980.6028558433845;1062.6280801719336;1090.1660229924114;1116.5422176907591;1146.8165093584987;13989.3704783285;14804.925975370053;15606.21968901573;16675.666486670198;16796.748048779278;708711;714082;715664;717332;718200;47950.04099918052;55620;55668.72165639227;56026.87946241052;56211.71894140503;1375.0649558300252;1379.9586012419643;1400.472147773279;1400.4748219417718;1402.1306789790394;30086.699133009264;30677.63141450282;31150.53274200934;31408.528872067393;31580.052598422084;48803.511964879894;49122.75438622784;49137.26294105663;49192.754036231025;49310.75344623254;627970;631510;632877;633054;634422;21061.89469052645;26363.86818065974;26454.603180952687;26467.073652422074;26476.205713828615;46260;46286;46454.53545464502;46519.87616099071;46735.53264467312;39048;39234.803825980685;39297.60702392939;39923.60076399315;40419.79790101031;38775.80612096922;38892.80553597214;39116;40100.997475063356;40220.99447513836;31725;37324.06689832776;37427;37460.43809342916;37885.05287367838;32874.83562582172;34181.829090854386;34786.478202827486;34825;34858.12854678653;25731.742682572934;25871;25910.48179036371;25987.870060649577;26335.946562138066 03:56:34 INFO - PROCESS | 1675 | |2;jquery.html;326.55751456776073;382.33855430105916;389.29343242015756;390.68549817396985;403.83039123568096;18903;20791.376258712262;20975.99999999998;21085.68371474427;21126.15495380183;20240.392788216377;20280.391588252376;20363.49091272719;20569.485762855937;20693.793062069373;4644.698094623838;5946.137810017545;6079.240094988127;6167.722452489626;6177.042558403455;3360;3504.4918486819397;5988;6505.219373675142;6828.112345395117;6560.934390656104;6770.052192693027;6810.148731408574;6825.35159159879;6850.760223392157;6663.333666633346;6772.424343930772;6780.864382712318;6782.864342713143;6793.5584187027935;5189.455107213726;5473.452654734535;5503.559715222773;5864.5894787364905;5884.323302820188;12878.29169395683;12927.15973461722;12974.286414247212;13167.736645267041;13204.339783010908;1920.7983161767952;2289.702338695959;2309.872956987365;2330.6270996640455;2341.660459233419;9808;9814.950925245328;9915.256355773347;10051.47318959377;10286.331388459726;1769.354185722215;1871.2421469304954;1878.117284876106;1879.0229080877866;1916.5208697825544;107396;117881;118102.81897181005;118744;119528;11853.111016673784;11856.70358241051;12002.39988000614;12004.699882503008;12108.273503589637;14487.420503179756;14539;14545.92727036358;14579.052361596463;14613.707725845636;8407.537585432738;8595.527246001406;8659.220670139717;8721.781955451164;8750.081241469681;8492.660293588187;8572.571371431404;8608.65565377378;8717;8732.388732788644;4463.933041004388;4565.960762515505;4590.632749380042;4610.907781844345;4723.102610503994;1756.9472915812546;1819.8775234269933;1832.743415921772;1893.2521653946615;1912.5123093611319;871.8387098386819;885.3050355471053;896.251629889037;907.3739120007174;996.7159359582485;21249.043793029352;21519.354419367442;21538.46153846135;21659.45851353697;21876.671849922262;939.2251392601131;967.8548217767391;1002.5989604158395;1010.5806090472519;1073.8442925775719;10974.451277436096;11358.829617555743;11406.80228576004;11445.027172690414;11499.252548584314;440554.7972260118;465483;489094;599880;611046;93051.67370815648;95713.0428695718;112338.87661123447;113640.15899602576;121006;940.5955439161089;949.3544389814992;976.4775844923074;976.5898322704339;976.951152442375;17988.55028624295;18103.72844407361;18262.36081737133;18284.72572911381;18330.90834545819;47268.7636561815;49179.01641967212;52448.73775631098;54502;55416.44583554274;70013;79301.04034458255;79998;81462.3707525858;81811;7965.442419030844;8060.758177254692;8206.507609543447;8546.017208021158;8550.315974722133;9124.133207345292;11325.71685707864;11791.705207369885;12299.385030748248;13094.214347139203;11128.499217535069;11340.376279304717;11567.884321157017;11660.12549058807;11865.466054027416;9311.301652376234;11192.1605879561;11286.266392684449;11312.94343528277;11424.200305978502;11606.883931160917;11694;11711.76576468483;11891;11898.702532436411;8161.306288965505;8348.206920342558;8424.536650484037;8462.534560599226;8511.74464766058;8160;10632.681019569116;11170.720731981766;11343.829842552534;11550.711232218926 03:56:34 INFO - PROCESS | 1675 | |3;mootools.html;1516.4086006457483;1560.594245496171;1741.712617418126;1823.4347352320774;1852.3516769130806;7960.840783184332;8244.58777061146;8474.491530508167;9054.456732596049;9079;8509.404341696083;8804.20762131408;8813.294936405087;8911.420757650749;8913.376063675545;2376.9881150594265;2379.9766100576744;2408.6025805742033;2410.3974006498374;2414.263649586875;2379.0245999140357;2384.213209640823;2391.9521609567796;2405.458771776354;2420.4630059911906;2385.7017872765905;2389.82076344274;2393.688820453339;2411.9758802412016;2420.2739178246543;2370.12305446984;2381.8570885746913;2383.5828729972186;2385.212879749687;2394.604890193125;2348.178137651825;2353;2360.2565191964477;2360.3509035015336;2371.1345358944036;8871.024187339388;8894.377393582452;8993.865092023625;8998.86501702475;9005.819883602357;5187.144121220032;5347.812826551091;5348.064088784447;5358.839234822962;5371.006363822706;3420.521127042216;3527.453244747043;3555.1645363339594;3565.893023209308;3577.4454959481063;958.1424624960621;959.8656188133667;972.9902700972971;977.6675930183771;987.1609132237612;11678.182527223098;11762.88237117635;11796.882031179664;11822.586209482713;11857.229280096766;4763.499832517605;4764.2615394613895;4812.56509021694;4878.365812444359;4889.071076495455;9943.602255909827;10052.64815731446;10061.044200800912;10072.697819065439;10168.237382196365;5396.541293989976;5430.809921652803;5435.945640543623;5439.809606663827;5443.42844001382;4438.201123797748;4570.223062079454;4811.49479304675;4940.135476291634;4979.45226025137;3412.19813343864;3489;4004.3593025116425;4010.839566417369;4137.710360274812;1205.5599706107382;1320.7094439223356;1329.7207586406769;1338.016557829994;1346.5556366399064;847.5804476783908;851.9148085191431;883.3728053082255;896.914793094655;928.5450129436528;4865.245886887538;5100.285959965608;5659.547236221092;5700.458456446631;5702.486776190163;802.7350974178507;901.5717534171347;938.4228699349851;941.18117238002;974.1573538888952;3511.2099777550357;3720.5907350191455;3768.5289338832645;3771.4531392948415;3799.772013679188;10456.111230545337;10960.780784384267;10967.122630189566;10970.616028438966;10973.725656858483;10892.891071089347;10893.618723344645;10894.836577451344;10912.945435272773;10934.343939363664;7688.038995125609;8241.670333186725;8373.916260837435;8389;8397.6221070052;5127.6410651254055;5664.461876121762;5800.6229595077875;5974.551908606785;6033;9783.315167938461;9815.852762208715;9888.555015024198;9929.3545919515;9947.552360143665;9719.659811906833;9879.654212102541;10092.646757363456;10099.89900101019;10150.847737283799;5873.794417195378;6992.26581208986;7209.891851622125;7555.13115991668;7699.15309315986;8273.46222495536;8277.917220827714;8410.53742044169;8425.705100321704;8446.788830279293;7303.744368947061;7408.888866667112;7461.552306861388;7461.776146715607;7540.1328847181085;7225.421966242583;7321.63391830417;7344.118705755343;7412;7429.108506979197;6962.7911162665205;7130.2869713028285;7132.536385134949;7135.393491553276;7136.536125151849;4015.377616469452;4221.598948099926;4550.180967425895;4664.673472857004;4983.875403114951;3965.4051892215243;4807.158747219153;4873.829415970424;4918.975405122951;5059.949400505948 03:56:34 INFO - PROCESS | 1675 | |4;prototype.html;264.57931888297605;288.75167356073774;315.41018295786876;315.76475525733315;320.549627772979;4526.70576412533;5546.556275497961;5568.443155684429;5580.469855363739;5632.240202300869;4677.976610116944;5154.48982140627;5514.035043867328;5521.613487055908;5542.251796007537;3929.978205666533;4126.711130220886;4145.274576949037;4151.3150330195485;4253.702240843142;4206.768627725474;4216.304309788881;4217.40956266123;4239.872803815891;4271.722338048033;4198.026927344144;4209;4216.241076606209;4224.978875105636;4274.529801721808;3504.526888869995;4046.1907618476275;4182.56083111275;4206.873793786161;4258.7870606469705;3597.5323207983056;3602.477640742104;3659.158393569494;3668.669819716238;3672.779633222015;5414.539764120054;5423.647462914898;5425.565954723613;5425.643589102724;5444.809431669913;4358.411614432042;4727.338172655831;4834.830780922686;4934.580560652349;4952.950470495285;4801.686836083091;5648.870225954825;5878.823635290948;5882.205902203191;5906.26171728534;4073.9388909166387;4084.447909794259;4088;4090.2842002649713;4090.3864420337186;5331.306930099101;5966.820995370146;6059.454649081604;6161.319825875758;6270.808546376174;3774.9245015100096;3866.1107945172766;4103.85636502721;4126.360414135814;4171.478565179353;3583.2654305867236;3918.941215881764;4196.706230563831;4212.220739163265;4216.30430978885;4659.440867095903;4876.780544875418;4879.56083952446;4912.852614421573;4912.852614421573;4845.491223421561;5895.35151133375;5955.37468565803;5963;6000.739844632589;1198.4726720243066;1210.3282678113555;1228.1893949993141;1336.4587342126454;1406.8241469816273;682.7712716240015;785.4855069929206;832.9375296852639;896.9686060987965;921.9907800922039;5080.466551012164;5127.846164614993;5274.208868669653;5569.693666848281;5578.665280083208;6076.969615151896;6111.8472038198515;6134.110553969649;6147.938520614736;6174.598651087665;5142;5524.309461317335;5561.443855614487;5643.730160713807;5665.773369065274;2886.769058475317;3141.7172454479205;3198.288915430234;3199.7280231180143;3206.4829109149673;5880.882382352329;6227.283862355887;6240.687965601702;6278.843028924313;6304.243490781136;4966.15575352191;5260.894782104337;5484.2596249505805;6314.968425157845;6420.582662126947;5614.831555053355;6203.565750397429;6422;6426.518011149183;6429.196350456193;5860.413958604106;5979.910301345396;6007.549433792396;6180.876382472416;6186.938130618636;6078.969605151946;6149.046897730859;6154.846128846635;6162.383761623981;6166.321704612579;5745.569082318926;5938.584299099194;6408.519361047846;6479.870402591828;6482.740690372332;3394.4385582632267;3398.5581874356176;3602.847088931622;3806.9238615226986;4039.212353591139;5641.643222282735;5668.064769313182;6224.813255602339;6235.625862448268;6271.592346497463;4615.861524154281;4845.2732090186755;5924.407559244041;6019.759209631566;6026.276846778414;5372.8985557961305;5471.68679516921;5973.313068997121;6002.219711437485;6060.545459090497;5088.516590923857;5563.916541251965;5644.322681278109;5732.05421105513;5909.734061967136;5332.146856502941;5386.569074473954;5675.290588676416;5796.449337312949;5903.763849446146;4823.831165909176;5353.946460535345;5813.854653633693;5814.76740930358;5817.912731308949 03:56:34 INFO - PROCESS | 1675 | |5;yui.html;703.669275440543;710.726370347416;777.7899967008908;784.4626430894838;806.3146325623218;15448.768268475967;15493.6126596835;15837.208139593004;15844.603884902883;15904.363825446982;13959.44162233512;14284.071535350195;14319.78520322196;14324.498642547513;14424.278786060708;661.0546917907391;682.1541288801875;819.4673462249526;824.0194168938958;837.7612380471567;847.2544161138189;847.4618617178074;848.2789628815519;848.8047749017729;849.2272032450471;912.4160537256162;914.8216097860919;916.6791622931987;917.8944421391559;918.3525614441802;903.3495882964288;906.9637214511412;908.8364094462994;910.886139232596;913.712180663089;668.8194187569329;670.9664516774142;673.1787219592089;674.81442603284;675.6824292582478;14742.262886855615;14862.2568871556;14866.182359970197;14886.553403397807;14912.925435372863;11328.94335528317;12443.880050795382;13492.662683432894;13497.865021349759;13571.524996625169;11016;11761.647150585497;11942.880571194264;11974.58088966882;12061.879381206163;3711.9072023199365;3724.348239058154;3805.9809700951596;3909.843606255746;3953.150072734376;95641.56537651941;96431;112877;114415;118922.40538797337;10835;10857.51141198648;10875;11061.778764424827;11207.327560346404;21391.358259252247;21484.785152148277;21781;21787.128514859545;21864.562708746053;8143.918560814434;8150.83698326042;8155.714549990722;8262.917370826335;8344.541050242295;4423.623991960655;4444.222560595118;4449.791323203979;4487.214737420938;4600.89578501164;3613.114786877232;3713.7400381973002;3738.5887552369218;3740.3267411866127;3745.513083299208;661.3122352753082;668.4585485756553;669.2805234373069;694.1358009278481;695.3394275438354;614.5421660862596;664.773976847874;665.411111166621;666.8099591616366;669.4410167510086;9150.633974641072;9627.951860240653;9649.52571143285;9748.756281093029;9883;432.4949176864529;526.2159382520094;548.7804878048732;664.5049438168595;669.8091044052421;4707.364505791743;4755.273864329001;4772.331873537708;4777.761111944389;4815.374001379798;97886;123473;132676;153351;161618.1919090397;109927.35108973371;122395.77604224022;129495;131119;141519.29240353938;116245;116713;120288.3985580084;120318.3984080074;121114;8660.48037117775;9176.403533770284;9456.446759375067;9718.416894986323;9739;54543.72728136334;58269.83460330685;58587.414125858195;58848;62393;88430;92191;93246.53376733072;93980;95507;13017.21896686202;13139.14595551286;13218.405171767101;13245.27151006704;13586.388612512263;11973.461194246105;14827.40690372373;14840.785554080214;14904.18027008525;14946.347082979571;13389.732205356033;13625.523106691615;13764.449422023408;13930.09731782544;14263.215523145911;12487.31319777421;12919.418626162033;13299.534516291884;14006.299685015912;14404.783928241295;11649.88350116488;13158.736825263633;13264.270465124126;13478.797818032934;13749.793753093913;11149.832752508557;11206.551737930391;11239.775204496027;11262.662120136409;11281.266717663326;11200.719982000515;11521.308721476404;11771.23486973344;11773.587924422603;11803.173777835469 03:56:34 INFO - PROCESS | 1675 | __end_tp_report 03:56:34 INFO - PROCESS | 1675 | __start_cc_report 03:56:34 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,365 03:56:34 INFO - PROCESS | 1675 | __end_cc_report 03:56:34 INFO - PROCESS | 1675 | __startTimestamp1478170594972__endTimestamp 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | ------- Summary: start ------- 03:56:34 INFO - PROCESS | 1675 | Number of tests: 6 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5760.37 Median:6106.96 stddev:712.35 (11.7%) stddev-sans-first:690.43 03:56:34 INFO - PROCESS | 1675 | Values: 3418.1 3426.8 3456.0 3457.3 3484.2 4325.9 4758.6 5191.1 5663.7 5974.3 4580.8 5652.5 5891.1 5938.1 6015.4 4317.5 5312.5 5423.3 5426.7 5454.0 4274.5 4704.2 5149.8 5402.1 5434.3 4269.6 4434.2 5301.8 5429.0 5444.4 4607.2 5311.2 5360.9 5366.6 5378.3 5284.8 5330.3 5335.0 5412.0 5412.4 4819.8 5849.0 6013.7 6042.6 6113.5 6238.8 6294.5 6306.5 6320.8 6322.7 6344.4 6356.7 6366.7 6372.2 6377.4 5868.4 5949.0 6004.5 6057.7 6070.7 5474.8 6429.1 6434.5 6449.1 6451.7 5144.4 6275.4 6284.7 6304.4 6310.8 6180.1 6192.0 6205.7 6211.0 6280.1 5242.7 6224.6 6250.4 6296.5 6307.8 6211.7 6246.8 6261.1 6277.4 6307.0 4895.4 4954.3 4984.9 4989.8 5027.7 4488.9 4505.0 4555.7 4563.7 4608.1 6020.8 6099.2 6111.8 6116.4 6121.5 6210.3 6217.9 6264.7 6326.1 6350.8 6064.2 6136.6 6138.6 6139.5 6144.9 5497.0 5525.4 5552.0 5556.5 5564.0 6203.3 6257.0 6487.6 6492.5 6505.3 5404.7 5439.5 6098.3 6314.7 6321.8 5352.5 6458.6 6461.4 6477.0 6480.4 6137.1 6309.4 6331.4 6333.2 6347.6 5365.7 5435.8 6235.2 6255.9 6317.3 5554.0 5879.9 6245.9 6285.5 6286.2 6215.4 6236.8 6264.7 6271.0 6284.2 5013.8 5935.9 5984.2 6099.2 6107.0 6206.0 6229.9 6253.8 6257.3 6262.0 6156.5 6161.3 6182.1 6183.2 6195.5 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:74016.14 Median:40464.49 stddev:168861.85 (417.3%) stddev-sans-first:169245.31 03:56:34 INFO - PROCESS | 1675 | Values: 489.4 518.7 530.5 534.0 539.9 30828.0 40468.2 40531.0 40591.8 40627.6 36219.0 41254.0 41711.4 41754.8 41826.9 9537.7 9696.0 9696.6 9698.6 9722.6 9729.2 9759.3 9830.3 9850.6 9864.0 9817.0 9852.4 9855.9 9860.3 9860.9 9756.7 9798.8 9825.6 9825.9 9839.4 9479.8 9567.2 9583.3 9583.8 9604.7 40389.8 40460.8 40557.4 40635.0 40733.0 3230.9 3511.8 3744.5 3860.4 4057.3 30040.5 30110.5 30779.2 30901.1 31672.0 2664.3 2730.7 3190.5 3259.0 3262.5 520763.4 527974.0 528858.0 529938.0 533635.0 58118.0 58226.0 58359.0 58513.0 58553.0 34170.8 34509.5 34586.8 35775.8 59713.0 17068.0 17180.3 17185.9 17198.7 17209.7 12962.3 13036.7 13042.3 13060.1 13088.7 18893.3 18968.6 18993.2 19098.9 19147.9 6878.4 7853.1 7926.8 8011.9 8068.8 839.2 846.3 867.0 908.9 960.5 23658.4 26106.6 28009.3 28481.3 30654.5 980.6 1062.6 1090.2 1116.5 1146.8 13989.4 14804.9 15606.2 16675.7 16796.7 708711.0 714082.0 715664.0 717332.0 718200.0 47950.0 55620.0 55668.7 56026.9 56211.7 1375.1 1380.0 1400.5 1400.5 1402.1 30086.7 30677.6 31150.5 31408.5 31580.1 48803.5 49122.8 49137.3 49192.8 49310.8 627970.0 631510.0 632877.0 633054.0 634422.0 21061.9 26363.9 26454.6 26467.1 26476.2 46260.0 46286.0 46454.5 46519.9 46735.5 39048.0 39234.8 39297.6 39923.6 40419.8 38775.8 38892.8 39116.0 40101.0 40221.0 31725.0 37324.1 37427.0 37460.4 37885.1 32874.8 34181.8 34786.5 34825.0 34858.1 25731.7 25871.0 25910.5 25987.9 26335.9 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:31964.18 Median:1843.28 stddev:88030.01 (4775.7%) stddev-sans-first:88244.91 03:56:34 INFO - PROCESS | 1675 | Values: 326.6 382.3 389.3 390.7 403.8 18903.0 20791.4 20976.0 21085.7 21126.2 20240.4 20280.4 20363.5 20569.5 20693.8 4644.7 5946.1 6079.2 6167.7 6177.0 3360.0 3504.5 5988.0 6505.2 6828.1 6560.9 6770.1 6810.1 6825.4 6850.8 6663.3 6772.4 6780.9 6782.9 6793.6 5189.5 5473.5 5503.6 5864.6 5884.3 12878.3 12927.2 12974.3 13167.7 13204.3 1920.8 2289.7 2309.9 2330.6 2341.7 9808.0 9815.0 9915.3 10051.5 10286.3 1769.4 1871.2 1878.1 1879.0 1916.5 107396.0 117881.0 118102.8 118744.0 119528.0 11853.1 11856.7 12002.4 12004.7 12108.3 14487.4 14539.0 14545.9 14579.1 14613.7 8407.5 8595.5 8659.2 8721.8 8750.1 8492.7 8572.6 8608.7 8717.0 8732.4 4463.9 4566.0 4590.6 4610.9 4723.1 1756.9 1819.9 1832.7 1893.3 1912.5 871.8 885.3 896.3 907.4 996.7 21249.0 21519.4 21538.5 21659.5 21876.7 939.2 967.9 1002.6 1010.6 1073.8 10974.5 11358.8 11406.8 11445.0 11499.3 440554.8 465483.0 489094.0 599880.0 611046.0 93051.7 95713.0 112338.9 113640.2 121006.0 940.6 949.4 976.5 976.6 977.0 17988.6 18103.7 18262.4 18284.7 18330.9 47268.8 49179.0 52448.7 54502.0 55416.4 70013.0 79301.0 79998.0 81462.4 81811.0 7965.4 8060.8 8206.5 8546.0 8550.3 9124.1 11325.7 11791.7 12299.4 13094.2 11128.5 11340.4 11567.9 11660.1 11865.5 9311.3 11192.2 11286.3 11312.9 11424.2 11606.9 11694.0 11711.8 11891.0 11898.7 8161.3 8348.2 8424.5 8462.5 8511.7 8160.0 10632.7 11170.7 11343.8 11550.7 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5687.09 Median:4981.66 stddev:3230.97 (64.9%) stddev-sans-first:3224.83 03:56:34 INFO - PROCESS | 1675 | Values: 1516.4 1560.6 1741.7 1823.4 1852.4 7960.8 8244.6 8474.5 9054.5 9079.0 8509.4 8804.2 8813.3 8911.4 8913.4 2377.0 2380.0 2408.6 2410.4 2414.3 2379.0 2384.2 2392.0 2405.5 2420.5 2385.7 2389.8 2393.7 2412.0 2420.3 2370.1 2381.9 2383.6 2385.2 2394.6 2348.2 2353.0 2360.3 2360.4 2371.1 8871.0 8894.4 8993.9 8998.9 9005.8 5187.1 5347.8 5348.1 5358.8 5371.0 3420.5 3527.5 3555.2 3565.9 3577.4 958.1 959.9 973.0 977.7 987.2 11678.2 11762.9 11796.9 11822.6 11857.2 4763.5 4764.3 4812.6 4878.4 4889.1 9943.6 10052.6 10061.0 10072.7 10168.2 5396.5 5430.8 5435.9 5439.8 5443.4 4438.2 4570.2 4811.5 4940.1 4979.5 3412.2 3489.0 4004.4 4010.8 4137.7 1205.6 1320.7 1329.7 1338.0 1346.6 847.6 851.9 883.4 896.9 928.5 4865.2 5100.3 5659.5 5700.5 5702.5 802.7 901.6 938.4 941.2 974.2 3511.2 3720.6 3768.5 3771.5 3799.8 10456.1 10960.8 10967.1 10970.6 10973.7 10892.9 10893.6 10894.8 10912.9 10934.3 7688.0 8241.7 8373.9 8389.0 8397.6 5127.6 5664.5 5800.6 5974.6 6033.0 9783.3 9815.9 9888.6 9929.4 9947.6 9719.7 9879.7 10092.6 10099.9 10150.8 5873.8 6992.3 7209.9 7555.1 7699.2 8273.5 8277.9 8410.5 8425.7 8446.8 7303.7 7408.9 7461.6 7461.8 7540.1 7225.4 7321.6 7344.1 7412.0 7429.1 6962.8 7130.3 7132.5 7135.4 7136.5 4015.4 4221.6 4550.2 4664.7 4983.9 3965.4 4807.2 4873.8 4919.0 5059.9 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:4778.10 Median:5419.09 stddev:1505.04 (27.8%) stddev-sans-first:1470.64 03:56:34 INFO - PROCESS | 1675 | Values: 264.6 288.8 315.4 315.8 320.5 4526.7 5546.6 5568.4 5580.5 5632.2 4678.0 5154.5 5514.0 5521.6 5542.3 3930.0 4126.7 4145.3 4151.3 4253.7 4206.8 4216.3 4217.4 4239.9 4271.7 4198.0 4209.0 4216.2 4225.0 4274.5 3504.5 4046.2 4182.6 4206.9 4258.8 3597.5 3602.5 3659.2 3668.7 3672.8 5414.5 5423.6 5425.6 5425.6 5444.8 4358.4 4727.3 4834.8 4934.6 4953.0 4801.7 5648.9 5878.8 5882.2 5906.3 4073.9 4084.4 4088.0 4090.3 4090.4 5331.3 5966.8 6059.5 6161.3 6270.8 3774.9 3866.1 4103.9 4126.4 4171.5 3583.3 3918.9 4196.7 4212.2 4216.3 4659.4 4876.8 4879.6 4912.9 4912.9 4845.5 5895.4 5955.4 5963.0 6000.7 1198.5 1210.3 1228.2 1336.5 1406.8 682.8 785.5 832.9 897.0 922.0 5080.5 5127.8 5274.2 5569.7 5578.7 6077.0 6111.8 6134.1 6147.9 6174.6 5142.0 5524.3 5561.4 5643.7 5665.8 2886.8 3141.7 3198.3 3199.7 3206.5 5880.9 6227.3 6240.7 6278.8 6304.2 4966.2 5260.9 5484.3 6315.0 6420.6 5614.8 6203.6 6422.0 6426.5 6429.2 5860.4 5979.9 6007.5 6180.9 6186.9 6079.0 6149.0 6154.8 6162.4 6166.3 5745.6 5938.6 6408.5 6479.9 6482.7 3394.4 3398.6 3602.8 3806.9 4039.2 5641.6 5668.1 6224.8 6235.6 6271.6 4615.9 4845.3 5924.4 6019.8 6026.3 5372.9 5471.7 5973.3 6002.2 6060.5 5088.5 5563.9 5644.3 5732.1 5909.7 5332.1 5386.6 5675.3 5796.4 5903.8 4823.8 5353.9 5813.9 5814.8 5817.9 03:56:34 INFO - PROCESS | 1675 | 03:56:34 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:24498.21 Median:3731.47 stddev:38820.17 (1040.3%) stddev-sans-first:38887.95 03:56:34 INFO - PROCESS | 1675 | Values: 703.7 710.7 777.8 784.5 806.3 15448.8 15493.6 15837.2 15844.6 15904.4 13959.4 14284.1 14319.8 14324.5 14424.3 661.1 682.2 819.5 824.0 837.8 847.3 847.5 848.3 848.8 849.2 912.4 914.8 916.7 917.9 918.4 903.3 907.0 908.8 910.9 913.7 668.8 671.0 673.2 674.8 675.7 14742.3 14862.3 14866.2 14886.6 14912.9 11328.9 12443.9 13492.7 13497.9 13571.5 11016.0 11761.6 11942.9 11974.6 12061.9 3711.9 3724.3 3806.0 3909.8 3953.2 95641.6 96431.0 112877.0 114415.0 118922.4 10835.0 10857.5 10875.0 11061.8 11207.3 21391.4 21484.8 21781.0 21787.1 21864.6 8143.9 8150.8 8155.7 8262.9 8344.5 4423.6 4444.2 4449.8 4487.2 4600.9 3613.1 3713.7 3738.6 3740.3 3745.5 661.3 668.5 669.3 694.1 695.3 614.5 664.8 665.4 666.8 669.4 9150.6 9628.0 9649.5 9748.8 9883.0 432.5 526.2 548.8 664.5 669.8 4707.4 4755.3 4772.3 4777.8 4815.4 97886.0 123473.0 132676.0 153351.0 161618.2 109927.4 122395.8 129495.0 131119.0 141519.3 116245.0 116713.0 120288.4 120318.4 121114.0 8660.5 9176.4 9456.4 9718.4 9739.0 54543.7 58269.8 58587.4 58848.0 62393.0 88430.0 92191.0 93246.5 93980.0 95507.0 13017.2 13139.1 13218.4 13245.3 13586.4 11973.5 14827.4 14840.8 14904.2 14946.3 13389.7 13625.5 13764.4 13930.1 14263.2 12487.3 12919.4 13299.5 14006.3 14404.8 11649.9 13158.7 13264.3 13478.8 13749.8 11149.8 11206.6 11239.8 11262.7 11281.3 11200.7 11521.3 11771.2 11773.6 11803.2 03:56:34 INFO - PROCESS | 1675 | -------- Summary: end -------- 03:56:34 INFO - PROCESS | 1675 | 03:56:35 INFO - TEST-INFO | 1675: exit 0 03:56:35 INFO - TEST-OK | dromaeo_css | took 1114268ms 03:56:35 INFO - TEST-START | kraken 03:56:35 INFO - operating with platform_type : mac_ 03:56:35 INFO - Initialising browser for kraken test... 03:56:35 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpgrqXtR/profile http://localhost:49280/getInfo.html) 03:56:38 INFO - PROCESS | 1688 | __metrics Screen width/height:1600/1200 03:56:38 INFO - PROCESS | 1688 | colorDepth:24 03:56:38 INFO - PROCESS | 1688 | Browser inner width/height: 1024/689 03:56:38 INFO - PROCESS | 1688 | __metrics 03:56:38 ERROR - PROCESS | 1688 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:56:39 INFO - TEST-INFO | 1688: exit 0 03:56:39 INFO - Browser initialized. 03:56:39 INFO - Running cycle 1/1 for kraken test... 03:56:39 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/T/tmpgrqXtR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:56:51 INFO - PROCESS | 1690 | RSS: Main: 225644544 03:56:51 INFO - PROCESS | 1690 | 03:56:53 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:54 INFO - PROCESS | 1690 | RSS: Main: 237748224 03:56:54 INFO - PROCESS | 1690 | 03:56:57 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 03:56:58 INFO - PROCESS | 1690 | RSS: Main: 245305344 03:56:58 INFO - PROCESS | 1690 | 03:57:01 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 03:57:02 INFO - PROCESS | 1690 | RSS: Main: 247115776 03:57:02 INFO - PROCESS | 1690 | 03:57:04 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 03:57:04 INFO - PROCESS | 1690 | RSS: Main: 248909824 03:57:04 INFO - PROCESS | 1690 | 03:57:06 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:57:07 INFO - PROCESS | 1690 | RSS: Main: 250519552 03:57:07 INFO - PROCESS | 1690 | 03:57:10 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 03:57:11 INFO - PROCESS | 1690 | RSS: Main: 250982400 03:57:11 INFO - PROCESS | 1690 | 03:57:14 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 03:57:14 INFO - PROCESS | 1690 | RSS: Main: 251199488 03:57:14 INFO - PROCESS | 1690 | 03:57:17 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 03:57:18 INFO - PROCESS | 1690 | RSS: Main: 251219968 03:57:18 INFO - PROCESS | 1690 | 03:57:19 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:57:20 INFO - PROCESS | 1690 | RSS: Main: 251138048 03:57:20 INFO - PROCESS | 1690 | 03:57:22 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:57:23 INFO - PROCESS | 1690 | RSS: Main: 251191296 03:57:23 INFO - PROCESS | 1690 | 03:57:25 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:57:25 INFO - PROCESS | 1690 | RSS: Main: 251162624 03:57:25 INFO - PROCESS | 1690 | 03:57:28 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:57:29 INFO - PROCESS | 1690 | RSS: Main: 251572224 03:57:29 INFO - PROCESS | 1690 | 03:57:32 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:57:33 INFO - PROCESS | 1690 | RSS: Main: 251535360 03:57:33 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 03:57:35 INFO - PROCESS | 1690 | RSS: Main: 252870656 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | __start_tp_report 03:57:35 INFO - PROCESS | 1690 | _x_x_mozilla_page_load 03:57:35 INFO - PROCESS | 1690 | _x_x_mozilla_page_load_details 03:57:35 INFO - PROCESS | 1690 | |i|pagename|runs| 03:57:35 INFO - PROCESS | 1690 | |0;ai-astar;109;118;125;173;166;117;117;118;117;118 03:57:35 INFO - PROCESS | 1690 | |1;audio-beat-detection;142;112;110;166;143;105;144;145;204;113 03:57:35 INFO - PROCESS | 1690 | |2;audio-dft;192;217;232;210;203;179;215;182;277;276 03:57:35 INFO - PROCESS | 1690 | |3;audio-fft;81;60;59;74;76;85;49;75;97;86 03:57:35 INFO - PROCESS | 1690 | |4;audio-oscillator;89;71;89;72;70;70;103;70;71;86 03:57:35 INFO - PROCESS | 1690 | |5;imaging-gaussian-blur;138;114;90;102;119;85;136;113;126;132 03:57:35 INFO - PROCESS | 1690 | |6;imaging-darkroom;94;96;138;114;94;94;96;112;155;99 03:57:35 INFO - PROCESS | 1690 | |7;imaging-desaturate;98;94;92;92;94;90;138;92;91;129 03:57:35 INFO - PROCESS | 1690 | |8;json-parse-financial;56;55;55;59;58;60;60;59;60;58 03:57:35 INFO - PROCESS | 1690 | |9;json-stringify-tinderbox;68;71;76;78;75;71;70;73;112;110 03:57:35 INFO - PROCESS | 1690 | |10;stanford-crypto-aes;86;85;84;84;85;83;83;85;82;83 03:57:35 INFO - PROCESS | 1690 | |11;stanford-crypto-ccm;152;155;163;149;160;158;156;152;187;160 03:57:35 INFO - PROCESS | 1690 | |12;stanford-crypto-pbkdf2;165;176;224;166;165;165;167;163;169;233 03:57:35 INFO - PROCESS | 1690 | |13;stanford-crypto-sha256-iterative;68;69;69;68;68;69;78;78;85;87 03:57:35 INFO - PROCESS | 1690 | __end_tp_report 03:57:35 INFO - PROCESS | 1690 | __start_cc_report 03:57:35 INFO - PROCESS | 1690 | _x_x_mozilla_cycle_collect,963 03:57:35 INFO - PROCESS | 1690 | __end_cc_report 03:57:35 INFO - PROCESS | 1690 | __startTimestamp1478170655348__endTimestamp 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | ------- Summary: start ------- 03:57:35 INFO - PROCESS | 1690 | Number of tests: 14 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#0] ai-astar Cycles:10 Average:127.80 Median:118.00 stddev:22.36 (19.0%) stddev-sans-first:22.66 03:57:35 INFO - PROCESS | 1690 | Values: 109.0 118.0 125.0 173.0 166.0 117.0 117.0 118.0 117.0 118.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:143.50 stddev:30.62 (21.3%) stddev-sans-first:32.45 03:57:35 INFO - PROCESS | 1690 | Values: 142.0 112.0 110.0 166.0 143.0 105.0 144.0 145.0 204.0 113.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#2] audio-dft Cycles:10 Average:218.30 Median:216.00 stddev:34.69 (16.1%) stddev-sans-first:35.47 03:57:35 INFO - PROCESS | 1690 | Values: 192.0 217.0 232.0 210.0 203.0 179.0 215.0 182.0 277.0 276.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#3] audio-fft Cycles:10 Average:74.20 Median:78.50 stddev:14.51 (18.5%) stddev-sans-first:15.17 03:57:35 INFO - PROCESS | 1690 | Values: 81.0 60.0 59.0 74.0 76.0 85.0 49.0 75.0 97.0 86.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:71.50 stddev:11.76 (16.4%) stddev-sans-first:11.92 03:57:35 INFO - PROCESS | 1690 | Values: 89.0 71.0 89.0 72.0 70.0 70.0 103.0 70.0 71.0 86.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:134.00 stddev:18.54 (13.8%) stddev-sans-first:17.78 03:57:35 INFO - PROCESS | 1690 | Values: 138.0 114.0 90.0 102.0 119.0 85.0 136.0 113.0 126.0 132.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#6] imaging-darkroom Cycles:10 Average:109.20 Median:94.00 stddev:21.35 (22.7%) stddev-sans-first:21.93 03:57:35 INFO - PROCESS | 1690 | Values: 94.0 96.0 138.0 114.0 94.0 94.0 96.0 112.0 155.0 99.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#7] imaging-desaturate Cycles:10 Average:101.00 Median:92.00 stddev:17.40 (18.9%) stddev-sans-first:18.42 03:57:35 INFO - PROCESS | 1690 | Values: 98.0 94.0 92.0 92.0 94.0 90.0 138.0 92.0 91.0 129.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:59.00 stddev:2.00 (3.4%) stddev-sans-first:1.99 03:57:35 INFO - PROCESS | 1690 | Values: 56.0 55.0 55.0 59.0 58.0 60.0 60.0 59.0 60.0 58.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#9] json-stringify-tinderbox Cycles:10 Average:80.40 Median:72.00 stddev:16.41 (22.8%) stddev-sans-first:16.78 03:57:35 INFO - PROCESS | 1690 | Values: 68.0 71.0 76.0 78.0 75.0 71.0 70.0 73.0 112.0 110.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.09 03:57:35 INFO - PROCESS | 1690 | Values: 86.0 85.0 84.0 84.0 85.0 83.0 83.0 85.0 82.0 83.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#11] stanford-crypto-ccm Cycles:10 Average:159.20 Median:159.00 stddev:10.67 (6.7%) stddev-sans-first:11.00 03:57:35 INFO - PROCESS | 1690 | Values: 152.0 155.0 163.0 149.0 160.0 158.0 156.0 152.0 187.0 160.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:168.00 stddev:26.26 (15.6%) stddev-sans-first:27.34 03:57:35 INFO - PROCESS | 1690 | Values: 165.0 176.0 224.0 166.0 165.0 165.0 167.0 163.0 169.0 233.0 03:57:35 INFO - PROCESS | 1690 | 03:57:35 INFO - PROCESS | 1690 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:73.50 stddev:7.49 (10.2%) stddev-sans-first:7.63 03:57:35 INFO - PROCESS | 1690 | Values: 68.0 69.0 69.0 68.0 68.0 69.0 78.0 78.0 85.0 87.0 03:57:35 INFO - PROCESS | 1690 | -------- Summary: end -------- 03:57:35 INFO - PROCESS | 1690 | 03:57:36 INFO - TEST-INFO | 1690: exit 0 03:57:36 INFO - TEST-OK | kraken | took 60545ms 03:57:36 INFO - SUITE-END | took 1174s 03:57:36 INFO - Completed test suite (00:19:35) 03:57:36 INFO - javascript benchmark 03:57:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7380.045791321186, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.094205035666, 3426.8457919393627, 3456.032310952933, 3457.3431048100874, 3484.2334686369004, 4325.913481730364, 4758.571728544431, 5191.117510023296, 5663.716814159291, 5974.3428222895445, 4580.770961451923, 5652.547796176306, 5891.145783861348, 5938.1389698493695, 6015.428534289235, 4317.503487098977, 5312.4687531246955, 5423.322084739408, 5426.728663566825, 5454.045542030149, 4274.465691788527, 4704.176769065417, 5149.81975630853, 5402.135658294674, 5434.347878254615, 4269.6370808481315, 4434.246178149722, 5301.761420736057, 5429.0, 5444.373897001836, 4607.17070927233, 5311.176767601028, 5360.865978350534, 5366.570674346043, 5378.327709036371, 5284.81503147388, 5330.253764472977, 5334.973325133388, 5412.0, 5412.3505179378335, 4819.807207711688, 5848.97075514624, 6013.729382177812, 6042.607230530001, 6113.510919126459, 6238.781642642532, 6294.464970477515, 6306.49548036156, 6320.841978950517, 6322.71547780351, 6344.429001389897, 6356.682165891687, 6366.745330186787, 6372.171617689717, 6377.394147555975, 5868.383819698955, 5949.0481522956115, 6004.489618382399, 6057.697115144225, 6070.726817293233, 5474.781008759605, 6429.099926010363, 6434.549581529248, 6449.064885591657, 6451.677416129175, 5144.38267407906, 6275.435210831047, 6284.717187726564, 6304.432601065926, 6310.810675679737, 6180.072989051589, 6191.9690401547705, 6205.689715514206, 6211.037289220088, 6280.05799130125, 5242.68543887368, 6224.62652240867, 6250.3749625037135, 6296.464800492009, 6307.810765676945, 6211.720472578745, 6246.75739314364, 6261.060840873905, 6277.403646653561, 6307.0, 4895.4370247422, 4954.256861470808, 4984.8753781155765, 4989.775460104304, 5027.748612569357, 4488.932666010012, 4504.954950450519, 4555.703879247838, 4563.657725670588, 4608.055348653518, 6020.819375418744, 6099.207103076572, 6111.786087486917, 6116.3577824328695, 6121.540884433685, 6210.285817130997, 6217.937820621736, 6264.686765661699, 6326.114343991845, 6350.809475715736, 6064.241969753781, 6136.610985192662, 6138.602983404986, 6139.522803442411, 6144.941444616014, 5496.972515137399, 5525.364583072998, 5552.028395030934, 5556.499915007588, 5564.0, 6203.2556093269095, 6257.030160325156, 6487.643179625072, 6492.5455218134275, 6505.2844187138435, 5404.72976351173, 5439.5104440600535, 6098.32918378969, 6314.6842657866, 6321.810345689637, 5352.4915133062295, 6458.580192287486, 6461.418472337512, 6477.0, 6480.416762491398, 6137.079438084323, 6309.432151106423, 6331.430171284606, 6333.20834895638, 6347.587406818727, 5365.731713414391, 5435.782568697208, 6235.220597425322, 6255.906161407492, 6317.305096439296, 5553.972230138824, 5879.882402351844, 6245.906311405423, 6285.528585356208, 6286.214223222098, 6215.378462153749, 6236.844078898064, 6264.74941002373, 6270.968645156745, 6284.24589049317, 5013.774380152829, 5935.940640593712, 5984.16221728967, 6099.207103076572, 6106.961816491296, 6205.968970155121, 6229.937700623117, 6253.781117661042, 6257.2804127525915, 6262.0, 6156.476699480415, 6161.322254552086, 6182.103594978613, 6183.196184495987, 6195.535334849814], "value": 5718.3699787968, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.4273699771268, 518.6602775182253, 530.5119290252969, 533.9839804805856, 539.9406065332813, 30828.0, 40468.1906361873, 40531.0, 40591.79704101483, 40627.59372406279, 36219.0, 41254.0, 41711.374329385006, 41754.791226043904, 41826.908654567305, 9537.713868583936, 9696.0, 9696.563654635558, 9698.563564639573, 9722.611095556205, 9729.173020293283, 9759.316847820655, 9830.311878168532, 9850.605975760996, 9864.013598640115, 9817.0, 9852.359596626233, 9855.901440985606, 9860.260480463958, 9860.852087218698, 9756.658516951908, 9798.755031124243, 9825.557849896772, 9825.901740982641, 9839.360441571274, 9479.810403791886, 9567.186789122932, 9583.329166958316, 9583.760405989837, 9604.66383676568, 40389.79805100985, 40460.79769601163, 40557.39163912544, 40635.0, 40732.98167545835, 3230.9030729078167, 3511.8244087795506, 3744.5319335083113, 3860.3823388257742, 4057.3305404608204, 30040.54939175914, 30110.548341774673, 30779.230519236975, 30901.072967811, 31672.0, 2664.307280107186, 2730.699623041464, 3190.5214217867274, 3259.022293312021, 3262.5269335946155, 520763.39618302044, 527974.0, 528858.0, 529938.0, 533635.0, 58118.0, 58226.0, 58359.0, 58513.0, 58553.0, 34170.82914585461, 34509.48235776465, 34586.82706586451, 35775.82112089423, 59713.0, 17067.97592144475, 17180.312787488612, 17185.91407042982, 17198.65602687939, 17209.7418538722, 12962.28707421082, 13036.674083147996, 13042.282674452807, 13060.085793994329, 13088.738225235633, 18893.338733144275, 18968.620627587647, 18993.240270389306, 19098.949557774176, 19147.946862922396, 6878.415334696607, 7853.136155022943, 7926.841463170705, 8011.879821802678, 8068.8386232275025, 839.2404873589411, 846.3187134356779, 866.991330086691, 908.8911527935908, 960.4573416019927, 23658.4085397863, 26106.608400874004, 28009.299767505974, 28481.28796780097, 30654.54018189729, 980.6028558433845, 1062.6280801719336, 1090.1660229924114, 1116.5422176907591, 1146.8165093584987, 13989.3704783285, 14804.925975370053, 15606.21968901573, 16675.666486670198, 16796.748048779278, 708711.0, 714082.0, 715664.0, 717332.0, 718200.0, 47950.04099918052, 55620.0, 55668.72165639227, 56026.87946241052, 56211.71894140503, 1375.0649558300252, 1379.9586012419643, 1400.472147773279, 1400.4748219417718, 1402.1306789790394, 30086.699133009264, 30677.63141450282, 31150.53274200934, 31408.528872067393, 31580.052598422084, 48803.511964879894, 49122.75438622784, 49137.26294105663, 49192.754036231025, 49310.75344623254, 627970.0, 631510.0, 632877.0, 633054.0, 634422.0, 21061.89469052645, 26363.86818065974, 26454.603180952687, 26467.073652422074, 26476.205713828615, 46260.0, 46286.0, 46454.53545464502, 46519.87616099071, 46735.53264467312, 39048.0, 39234.803825980685, 39297.60702392939, 39923.60076399315, 40419.79790101031, 38775.80612096922, 38892.80553597214, 39116.0, 40100.997475063356, 40220.99447513836, 31725.0, 37324.06689832776, 37427.0, 37460.43809342916, 37885.05287367838, 32874.83562582172, 34181.829090854386, 34786.478202827486, 34825.0, 34858.12854678653, 25731.742682572934, 25871.0, 25910.48179036371, 25987.870060649577, 26335.946562138066], "value": 19832.49573990833, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.55751456776073, 382.33855430105916, 389.29343242015756, 390.68549817396985, 403.83039123568096, 18903.0, 20791.376258712262, 20975.99999999998, 21085.68371474427, 21126.15495380183, 20240.392788216377, 20280.391588252376, 20363.49091272719, 20569.485762855937, 20693.793062069373, 4644.698094623838, 5946.137810017545, 6079.240094988127, 6167.722452489626, 6177.042558403455, 3360.0, 3504.4918486819397, 5988.0, 6505.219373675142, 6828.112345395117, 6560.934390656104, 6770.052192693027, 6810.148731408574, 6825.35159159879, 6850.760223392157, 6663.333666633346, 6772.424343930772, 6780.864382712318, 6782.864342713143, 6793.5584187027935, 5189.455107213726, 5473.452654734535, 5503.559715222773, 5864.5894787364905, 5884.323302820188, 12878.29169395683, 12927.15973461722, 12974.286414247212, 13167.736645267041, 13204.339783010908, 1920.7983161767952, 2289.702338695959, 2309.872956987365, 2330.6270996640455, 2341.660459233419, 9808.0, 9814.950925245328, 9915.256355773347, 10051.47318959377, 10286.331388459726, 1769.354185722215, 1871.2421469304954, 1878.117284876106, 1879.0229080877866, 1916.5208697825544, 107396.0, 117881.0, 118102.81897181005, 118744.0, 119528.0, 11853.111016673784, 11856.70358241051, 12002.39988000614, 12004.699882503008, 12108.273503589637, 14487.420503179756, 14539.0, 14545.92727036358, 14579.052361596463, 14613.707725845636, 8407.537585432738, 8595.527246001406, 8659.220670139717, 8721.781955451164, 8750.081241469681, 8492.660293588187, 8572.571371431404, 8608.65565377378, 8717.0, 8732.388732788644, 4463.933041004388, 4565.960762515505, 4590.632749380042, 4610.907781844345, 4723.102610503994, 1756.9472915812546, 1819.8775234269933, 1832.743415921772, 1893.2521653946615, 1912.5123093611319, 871.8387098386819, 885.3050355471053, 896.251629889037, 907.3739120007174, 996.7159359582485, 21249.043793029352, 21519.354419367442, 21538.46153846135, 21659.45851353697, 21876.671849922262, 939.2251392601131, 967.8548217767391, 1002.5989604158395, 1010.5806090472519, 1073.8442925775719, 10974.451277436096, 11358.829617555743, 11406.80228576004, 11445.027172690414, 11499.252548584314, 440554.7972260118, 465483.0, 489094.0, 599880.0, 611046.0, 93051.67370815648, 95713.0428695718, 112338.87661123447, 113640.15899602576, 121006.0, 940.5955439161089, 949.3544389814992, 976.4775844923074, 976.5898322704339, 976.951152442375, 17988.55028624295, 18103.72844407361, 18262.36081737133, 18284.72572911381, 18330.90834545819, 47268.7636561815, 49179.01641967212, 52448.73775631098, 54502.0, 55416.44583554274, 70013.0, 79301.04034458255, 79998.0, 81462.3707525858, 81811.0, 7965.442419030844, 8060.758177254692, 8206.507609543447, 8546.017208021158, 8550.315974722133, 9124.133207345292, 11325.71685707864, 11791.705207369885, 12299.385030748248, 13094.214347139203, 11128.499217535069, 11340.376279304717, 11567.884321157017, 11660.12549058807, 11865.466054027416, 9311.301652376234, 11192.1605879561, 11286.266392684449, 11312.94343528277, 11424.200305978502, 11606.883931160917, 11694.0, 11711.76576468483, 11891.0, 11898.702532436411, 8161.306288965505, 8348.206920342558, 8424.536650484037, 8462.534560599226, 8511.74464766058, 8160.0, 10632.681019569116, 11170.720731981766, 11343.829842552534, 11550.711232218926], "value": 9366.572591542325, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1516.4086006457483, 1560.594245496171, 1741.712617418126, 1823.4347352320774, 1852.3516769130806, 7960.840783184332, 8244.58777061146, 8474.491530508167, 9054.456732596049, 9079.0, 8509.404341696083, 8804.20762131408, 8813.294936405087, 8911.420757650749, 8913.376063675545, 2376.9881150594265, 2379.9766100576744, 2408.6025805742033, 2410.3974006498374, 2414.263649586875, 2379.0245999140357, 2384.213209640823, 2391.9521609567796, 2405.458771776354, 2420.4630059911906, 2385.7017872765905, 2389.82076344274, 2393.688820453339, 2411.9758802412016, 2420.2739178246543, 2370.12305446984, 2381.8570885746913, 2383.5828729972186, 2385.212879749687, 2394.604890193125, 2348.178137651825, 2353.0, 2360.2565191964477, 2360.3509035015336, 2371.1345358944036, 8871.024187339388, 8894.377393582452, 8993.865092023625, 8998.86501702475, 9005.819883602357, 5187.144121220032, 5347.812826551091, 5348.064088784447, 5358.839234822962, 5371.006363822706, 3420.521127042216, 3527.453244747043, 3555.1645363339594, 3565.893023209308, 3577.4454959481063, 958.1424624960621, 959.8656188133667, 972.9902700972971, 977.6675930183771, 987.1609132237612, 11678.182527223098, 11762.88237117635, 11796.882031179664, 11822.586209482713, 11857.229280096766, 4763.499832517605, 4764.2615394613895, 4812.56509021694, 4878.365812444359, 4889.071076495455, 9943.602255909827, 10052.64815731446, 10061.044200800912, 10072.697819065439, 10168.237382196365, 5396.541293989976, 5430.809921652803, 5435.945640543623, 5439.809606663827, 5443.42844001382, 4438.201123797748, 4570.223062079454, 4811.49479304675, 4940.135476291634, 4979.45226025137, 3412.19813343864, 3489.0, 4004.3593025116425, 4010.839566417369, 4137.710360274812, 1205.5599706107382, 1320.7094439223356, 1329.7207586406769, 1338.016557829994, 1346.5556366399064, 847.5804476783908, 851.9148085191431, 883.3728053082255, 896.914793094655, 928.5450129436528, 4865.245886887538, 5100.285959965608, 5659.547236221092, 5700.458456446631, 5702.486776190163, 802.7350974178507, 901.5717534171347, 938.4228699349851, 941.18117238002, 974.1573538888952, 3511.2099777550357, 3720.5907350191455, 3768.5289338832645, 3771.4531392948415, 3799.772013679188, 10456.111230545337, 10960.780784384267, 10967.122630189566, 10970.616028438966, 10973.725656858483, 10892.891071089347, 10893.618723344645, 10894.836577451344, 10912.945435272773, 10934.343939363664, 7688.038995125609, 8241.670333186725, 8373.916260837435, 8389.0, 8397.6221070052, 5127.6410651254055, 5664.461876121762, 5800.6229595077875, 5974.551908606785, 6033.0, 9783.315167938461, 9815.852762208715, 9888.555015024198, 9929.3545919515, 9947.552360143665, 9719.659811906833, 9879.654212102541, 10092.646757363456, 10099.89900101019, 10150.847737283799, 5873.794417195378, 6992.26581208986, 7209.891851622125, 7555.13115991668, 7699.15309315986, 8273.46222495536, 8277.917220827714, 8410.53742044169, 8425.705100321704, 8446.788830279293, 7303.744368947061, 7408.888866667112, 7461.552306861388, 7461.776146715607, 7540.1328847181085, 7225.421966242583, 7321.63391830417, 7344.118705755343, 7412.0, 7429.108506979197, 6962.7911162665205, 7130.2869713028285, 7132.536385134949, 7135.393491553276, 7136.536125151849, 4015.377616469452, 4221.598948099926, 4550.180967425895, 4664.673472857004, 4983.875403114951, 3965.4051892215243, 4807.158747219153, 4873.829415970424, 4918.975405122951, 5059.949400505948], "value": 4556.545351567208, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.57931888297605, 288.75167356073774, 315.41018295786876, 315.76475525733315, 320.549627772979, 4526.70576412533, 5546.556275497961, 5568.443155684429, 5580.469855363739, 5632.240202300869, 4677.976610116944, 5154.48982140627, 5514.035043867328, 5521.613487055908, 5542.251796007537, 3929.978205666533, 4126.711130220886, 4145.274576949037, 4151.3150330195485, 4253.702240843142, 4206.768627725474, 4216.304309788881, 4217.40956266123, 4239.872803815891, 4271.722338048033, 4198.026927344144, 4209.0, 4216.241076606209, 4224.978875105636, 4274.529801721808, 3504.526888869995, 4046.1907618476275, 4182.56083111275, 4206.873793786161, 4258.7870606469705, 3597.5323207983056, 3602.477640742104, 3659.158393569494, 3668.669819716238, 3672.779633222015, 5414.539764120054, 5423.647462914898, 5425.565954723613, 5425.643589102724, 5444.809431669913, 4358.411614432042, 4727.338172655831, 4834.830780922686, 4934.580560652349, 4952.950470495285, 4801.686836083091, 5648.870225954825, 5878.823635290948, 5882.205902203191, 5906.26171728534, 4073.9388909166387, 4084.447909794259, 4088.0, 4090.2842002649713, 4090.3864420337186, 5331.306930099101, 5966.820995370146, 6059.454649081604, 6161.319825875758, 6270.808546376174, 3774.9245015100096, 3866.1107945172766, 4103.85636502721, 4126.360414135814, 4171.478565179353, 3583.2654305867236, 3918.941215881764, 4196.706230563831, 4212.220739163265, 4216.30430978885, 4659.440867095903, 4876.780544875418, 4879.56083952446, 4912.852614421573, 4912.852614421573, 4845.491223421561, 5895.35151133375, 5955.37468565803, 5963.0, 6000.739844632589, 1198.4726720243066, 1210.3282678113555, 1228.1893949993141, 1336.4587342126454, 1406.8241469816273, 682.7712716240015, 785.4855069929206, 832.9375296852639, 896.9686060987965, 921.9907800922039, 5080.466551012164, 5127.846164614993, 5274.208868669653, 5569.693666848281, 5578.665280083208, 6076.969615151896, 6111.8472038198515, 6134.110553969649, 6147.938520614736, 6174.598651087665, 5142.0, 5524.309461317335, 5561.443855614487, 5643.730160713807, 5665.773369065274, 2886.769058475317, 3141.7172454479205, 3198.288915430234, 3199.7280231180143, 3206.4829109149673, 5880.882382352329, 6227.283862355887, 6240.687965601702, 6278.843028924313, 6304.243490781136, 4966.15575352191, 5260.894782104337, 5484.2596249505805, 6314.968425157845, 6420.582662126947, 5614.831555053355, 6203.565750397429, 6422.0, 6426.518011149183, 6429.196350456193, 5860.413958604106, 5979.910301345396, 6007.549433792396, 6180.876382472416, 6186.938130618636, 6078.969605151946, 6149.046897730859, 6154.846128846635, 6162.383761623981, 6166.321704612579, 5745.569082318926, 5938.584299099194, 6408.519361047846, 6479.870402591828, 6482.740690372332, 3394.4385582632267, 3398.5581874356176, 3602.847088931622, 3806.9238615226986, 4039.212353591139, 5641.643222282735, 5668.064769313182, 6224.813255602339, 6235.625862448268, 6271.592346497463, 4615.861524154281, 4845.2732090186755, 5924.407559244041, 6019.759209631566, 6026.276846778414, 5372.8985557961305, 5471.68679516921, 5973.313068997121, 6002.219711437485, 6060.545459090497, 5088.516590923857, 5563.916541251965, 5644.322681278109, 5732.05421105513, 5909.734061967136, 5332.146856502941, 5386.569074473954, 5675.290588676416, 5796.449337312949, 5903.763849446146, 4823.831165909176, 5353.946460535345, 5813.854653633693, 5814.76740930358, 5817.912731308949], "value": 4277.714529667819, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.669275440543, 710.726370347416, 777.7899967008908, 784.4626430894838, 806.3146325623218, 15448.768268475967, 15493.6126596835, 15837.208139593004, 15844.603884902883, 15904.363825446982, 13959.44162233512, 14284.071535350195, 14319.78520322196, 14324.498642547513, 14424.278786060708, 661.0546917907391, 682.1541288801875, 819.4673462249526, 824.0194168938958, 837.7612380471567, 847.2544161138189, 847.4618617178074, 848.2789628815519, 848.8047749017729, 849.2272032450471, 912.4160537256162, 914.8216097860919, 916.6791622931987, 917.8944421391559, 918.3525614441802, 903.3495882964288, 906.9637214511412, 908.8364094462994, 910.886139232596, 913.712180663089, 668.8194187569329, 670.9664516774142, 673.1787219592089, 674.81442603284, 675.6824292582478, 14742.262886855615, 14862.2568871556, 14866.182359970197, 14886.553403397807, 14912.925435372863, 11328.94335528317, 12443.880050795382, 13492.662683432894, 13497.865021349759, 13571.524996625169, 11016.0, 11761.647150585497, 11942.880571194264, 11974.58088966882, 12061.879381206163, 3711.9072023199365, 3724.348239058154, 3805.9809700951596, 3909.843606255746, 3953.150072734376, 95641.56537651941, 96431.0, 112877.0, 114415.0, 118922.40538797337, 10835.0, 10857.51141198648, 10875.0, 11061.778764424827, 11207.327560346404, 21391.358259252247, 21484.785152148277, 21781.0, 21787.128514859545, 21864.562708746053, 8143.918560814434, 8150.83698326042, 8155.714549990722, 8262.917370826335, 8344.541050242295, 4423.623991960655, 4444.222560595118, 4449.791323203979, 4487.214737420938, 4600.89578501164, 3613.114786877232, 3713.7400381973002, 3738.5887552369218, 3740.3267411866127, 3745.513083299208, 661.3122352753082, 668.4585485756553, 669.2805234373069, 694.1358009278481, 695.3394275438354, 614.5421660862596, 664.773976847874, 665.411111166621, 666.8099591616366, 669.4410167510086, 9150.633974641072, 9627.951860240653, 9649.52571143285, 9748.756281093029, 9883.0, 432.4949176864529, 526.2159382520094, 548.7804878048732, 664.5049438168595, 669.8091044052421, 4707.364505791743, 4755.273864329001, 4772.331873537708, 4777.761111944389, 4815.374001379798, 97886.0, 123473.0, 132676.0, 153351.0, 161618.1919090397, 109927.35108973371, 122395.77604224022, 129495.0, 131119.0, 141519.29240353938, 116245.0, 116713.0, 120288.3985580084, 120318.3984080074, 121114.0, 8660.48037117775, 9176.403533770284, 9456.446759375067, 9718.416894986323, 9739.0, 54543.72728136334, 58269.83460330685, 58587.414125858195, 58848.0, 62393.0, 88430.0, 92191.0, 93246.53376733072, 93980.0, 95507.0, 13017.21896686202, 13139.14595551286, 13218.405171767101, 13245.27151006704, 13586.388612512263, 11973.461194246105, 14827.40690372373, 14840.785554080214, 14904.18027008525, 14946.347082979571, 13389.732205356033, 13625.523106691615, 13764.449422023408, 13930.09731782544, 14263.215523145911, 12487.31319777421, 12919.418626162033, 13299.534516291884, 14006.299685015912, 14404.783928241295, 11649.88350116488, 13158.736825263633, 13264.270465124126, 13478.797818032934, 13749.793753093913, 11149.832752508557, 11206.551737930391, 11239.775204496027, 11262.662120136409, 11281.266717663326, 11200.719982000515, 11521.308721476404, 11771.23486973344, 11773.587924422603, 11803.173777835469], "value": 7802.484304945928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 118.0, 125.0, 173.0, 166.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 127.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 112.0, 110.0, 166.0, 143.0, 105.0, 144.0, 145.0, 204.0, 113.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 217.0, 232.0, 210.0, 203.0, 179.0, 215.0, 182.0, 277.0, 276.0], "value": 218.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 74.0, 76.0, 85.0, 49.0, 75.0, 97.0, 86.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 89.0, 72.0, 70.0, 70.0, 103.0, 70.0, 71.0, 86.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 114.0, 90.0, 102.0, 119.0, 85.0, 136.0, 113.0, 126.0, 132.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 138.0, 114.0, 94.0, 94.0, 96.0, 112.0, 155.0, 99.0], "value": 109.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 94.0, 92.0, 92.0, 94.0, 90.0, 138.0, 92.0, 91.0, 129.0], "value": 101.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 59.0, 58.0, 60.0, 60.0, 59.0, 60.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 76.0, 78.0, 75.0, 71.0, 70.0, 73.0, 112.0, 110.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 84.0, 85.0, 83.0, 83.0, 85.0, 82.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 163.0, 149.0, 160.0, 158.0, 156.0, 152.0, 187.0, 160.0], "value": 159.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 176.0, 224.0, 166.0, 165.0, 165.0, 167.0, 163.0, 169.0, 233.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 78.0, 78.0, 85.0, 87.0], "value": 73.9, "unit": "score"}]}]} 03:57:36 INFO - Return code: 0 03:57:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:57:36 ERROR - # TBPL SUCCESS # 03:57:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:57:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:57:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:57:36 INFO - 2016-11-03 03:57:36.637 screenresolution[1695:10586] starting screenresolution argv=screenresolution get 03:57:36 INFO - 2016-11-03 03:57:36.639 screenresolution[1695:10586] Display 0: 1600x1200x32@60 03:57:36 INFO - 2016-11-03 03:57:36.645 screenresolution[1696:10589] starting screenresolution argv=screenresolution list 03:57:36 INFO - Available Modes on Display 0 03:57:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:57:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:57:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:57:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:57:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:57:36 INFO - Intel Iris: 03:57:36 INFO - Chipset Model: Intel Iris 03:57:36 INFO - Type: GPU 03:57:36 INFO - Bus: Built-In 03:57:36 INFO - VRAM (Dynamic, Max): 1536 MB 03:57:36 INFO - Vendor: Intel (0x8086) 03:57:36 INFO - Device ID: 0x0a2e 03:57:36 INFO - Revision ID: 0x0009 03:57:36 INFO - Displays: 03:57:36 INFO - Display: 03:57:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:57:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:57:36 INFO - Display Serial Number: 1600x1200 60 03:57:36 INFO - Main Display: Yes 03:57:36 INFO - Mirror: Off 03:57:36 INFO - Online: Yes 03:57:36 INFO - Rotation: Supported 03:57:36 INFO - Return code: 0 03:57:36 INFO - Running post-action listener: _resource_record_post_action 03:57:36 INFO - [mozharness: 2016-11-03 10:57:36.877749Z] Finished run-tests step (success) 03:57:36 INFO - Running post-run listener: _resource_record_post_run 03:57:36 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 38339584; Write bytes: 665193472; Read time: 380; Write time: 3042 03:57:36 INFO - TinderboxPrint: CPU usage
54.1% 03:57:36 INFO - TinderboxPrint: I/O read bytes / time
38,339,584 / 380 03:57:36 INFO - TinderboxPrint: I/O write bytes / time
665,193,472 / 3,042 03:57:36 INFO - TinderboxPrint: CPU idle
2,219.0 (45.9%) 03:57:36 INFO - TinderboxPrint: CPU system
975.7 (20.2%) 03:57:36 INFO - TinderboxPrint: CPU user
1,639.0 (33.9%) 03:57:36 INFO - TinderboxPrint: Swap in / out
401,895,424 / 0 03:57:36 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 358720000; Write bytes: 355706368; Read time: 27791; Write time: 669 03:57:36 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36373504; Write bytes: 298440192; Read time: 358; Write time: 2340 03:57:37 INFO - Running post-run listener: _upload_blobber_files 03:57:37 INFO - Blob upload gear active. 03:57:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:57:37 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 03:57:37 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:57:37 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:57:37 INFO - (blobuploader) - INFO - Open directory for files ... 03:57:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:57:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:38 INFO - (blobuploader) - INFO - Done attempting. 03:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:57:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:39 INFO - (blobuploader) - INFO - Done attempting. 03:57:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:57:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:57:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:57:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:57:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:57:41 INFO - (blobuploader) - INFO - Done attempting. 03:57:41 INFO - (blobuploader) - INFO - Iteration through files over. 03:57:41 INFO - Return code: 0 03:57:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:57:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:57:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3c6f26447216ae7e0e5f01a3cedff8753f0459e7445204f01a34d57673f9de970f51e52570d7e074061c33a9302fa5118235fd9b0d231f5a0c149b94edbb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dfa92fb45ec2fab33629418dc542a615ab4ea19e40c2fc15a9cec873456b93711f5fe7e5428604e0ceec70712da3f78b15e6e412905c4ea7661a5710abd3f84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bca870cf9afa55e3a8148e7ce9e239766be9bcc07098fdaceb8466deedded1ee6fecf947471bff311147e1d72d90dc1087f6e060493ffde7662b4ce5791bbe5"} 03:57:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:57:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:57:41 INFO - Contents: 03:57:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3c6f26447216ae7e0e5f01a3cedff8753f0459e7445204f01a34d57673f9de970f51e52570d7e074061c33a9302fa5118235fd9b0d231f5a0c149b94edbb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dfa92fb45ec2fab33629418dc542a615ab4ea19e40c2fc15a9cec873456b93711f5fe7e5428604e0ceec70712da3f78b15e6e412905c4ea7661a5710abd3f84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bca870cf9afa55e3a8148e7ce9e239766be9bcc07098fdaceb8466deedded1ee6fecf947471bff311147e1d72d90dc1087f6e060493ffde7662b4ce5791bbe5"} 03:57:41 INFO - Running post-run listener: copy_logs_to_upload_dir 03:57:41 INFO - Copying logs to upload dir... 03:57:41 INFO - mkdir: /builds/slave/test/build/upload/logs 03:57:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.538551 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-11-03 03:57:42.035929) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 03:57:42.040842) ========= 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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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/Mozilla-Aurora/sha512/dd3c6f26447216ae7e0e5f01a3cedff8753f0459e7445204f01a34d57673f9de970f51e52570d7e074061c33a9302fa5118235fd9b0d231f5a0c149b94edbb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dfa92fb45ec2fab33629418dc542a615ab4ea19e40c2fc15a9cec873456b93711f5fe7e5428604e0ceec70712da3f78b15e6e412905c4ea7661a5710abd3f84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bca870cf9afa55e3a8148e7ce9e239766be9bcc07098fdaceb8466deedded1ee6fecf947471bff311147e1d72d90dc1087f6e060493ffde7662b4ce5791bbe5"} build_url:https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011330 build_url: 'https://queue.taskcluster.net/v1/task/K9I54h-OTB2CPbeDlP-Jzw/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dd3c6f26447216ae7e0e5f01a3cedff8753f0459e7445204f01a34d57673f9de970f51e52570d7e074061c33a9302fa5118235fd9b0d231f5a0c149b94edbb91", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2dfa92fb45ec2fab33629418dc542a615ab4ea19e40c2fc15a9cec873456b93711f5fe7e5428604e0ceec70712da3f78b15e6e412905c4ea7661a5710abd3f84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5bca870cf9afa55e3a8148e7ce9e239766be9bcc07098fdaceb8466deedded1ee6fecf947471bff311147e1d72d90dc1087f6e060493ffde7662b4ce5791bbe5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-03 03:57:42.077129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 03:57:42.077570) ========= 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.4nAU0aiQCJ/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.wtKViBHvdJ/Listeners TMPDIR=/var/folders/7r/ywr7vtgn4tj6q7dzmd3w9_0h00000w/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.005188 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-03 03:57:42.126206) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 03:57:42.129569) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-03 03:57:42.129928) ========= ========= Total master_lag: 0.20 =========