builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0296 starttime: 1476894632.62 results: success (0) buildid: 20161019080022 builduid: 6bbf0919cb204ba69eba80c88c34cd4c revision: 8b2d92343bcb398075c909c587ec020286528059 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.621946) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.622425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.622697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.645435) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.645814) ========= 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.HODvUeb7js/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.JZOO5JPn70/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-19 09:30:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.07M=0.001s 2016-10-19 09:30:32 (8.07 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117436 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.784884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.785241) ========= 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.HODvUeb7js/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.JZOO5JPn70/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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.018907 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:32.833116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 09:30:32.833608) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b2d92343bcb398075c909c587ec020286528059 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8b2d92343bcb398075c909c587ec020286528059 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HODvUeb7js/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.JZOO5JPn70/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-19 09:30:32,915 truncating revision to first 12 chars 2016-10-19 09:30:32,915 Setting DEBUG logging. 2016-10-19 09:30:32,915 attempt 1/10 2016-10-19 09:30:32,915 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b2d92343bcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 09:30:34,509 unpacking tar archive at: mozilla-central-8b2d92343bcb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.874977 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-19 09:30:34.730403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:34.730741) ========= script_repo_revision: 8b2d92343bcb398075c909c587ec020286528059 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:34.731115) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:34.731388) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 09:30:34.749460) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-19 09:30:34.749852) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HODvUeb7js/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.JZOO5JPn70/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:30:34 INFO - MultiFileLogger online at 20161019 09:30:34 in /builds/slave/test 09:30:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:30:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:34 INFO - {'append_to_log': False, 09:30:34 INFO - 'base_work_dir': '/builds/slave/test', 09:30:34 INFO - 'blob_upload_branch': 'Firefox', 09:30:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:34 INFO - 'branch': 'Firefox', 09:30:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:34 INFO - 'config_files': ('talos/mac_config.py',), 09:30:34 INFO - 'default_actions': ('clobber', 09:30:34 INFO - 'read-buildbot-config', 09:30:34 INFO - 'download-and-extract', 09:30:34 INFO - 'populate-webroot', 09:30:34 INFO - 'create-virtualenv', 09:30:34 INFO - 'install', 09:30:34 INFO - 'run-tests'), 09:30:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:34 INFO - 'download_minidump_stackwalk': True, 09:30:34 INFO - 'download_symbols': 'ondemand', 09:30:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:34 INFO - 'installer_path': 'installer.exe', 09:30:34 INFO - 'log_level': 'info', 09:30:34 INFO - 'log_name': 'talos', 09:30:34 INFO - 'log_to_console': True, 09:30:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:30:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:30:34 INFO - 'opt_config_files': (), 09:30:34 INFO - 'pip_index': False, 09:30:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:30:34 INFO - 'cmd': ('bash', 09:30:34 INFO - '-c', 09:30:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:30:34 INFO - 'enabled': True, 09:30:34 INFO - 'halt_on_failure': False, 09:30:34 INFO - 'name': 'check_screen_resolution'},), 09:30:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:30:34 INFO - 'cmd': ('bash', 09:30:34 INFO - '-c', 09:30:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:30:34 INFO - 'enabled': True, 09:30:34 INFO - 'halt_on_failure': False, 09:30:34 INFO - 'name': 'check_screen_resolution'},), 09:30:34 INFO - 'run_cmd_checks_enabled': True, 09:30:34 INFO - 'sps_profile': False, 09:30:34 INFO - 'sps_profile_interval': 0, 09:30:34 INFO - 'suite': 'dromaeojs', 09:30:34 INFO - 'system_bits': '32', 09:30:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:34 INFO - 'title': 't-yosemite-r7-0296', 09:30:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:34 INFO - 'use_talos_json': True, 09:30:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:34 INFO - 'work_dir': 'build'} 09:30:34 INFO - [mozharness: 2016-10-19 16:30:34.952917Z] Running clobber step. 09:30:34 INFO - Running pre-action listener: _resource_record_pre_action 09:30:34 INFO - Running main action method: clobber 09:30:34 INFO - rmtree: /builds/slave/test/build 09:30:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:35 INFO - Running post-action listener: _resource_record_post_action 09:30:35 INFO - [mozharness: 2016-10-19 16:30:35.837733Z] Finished clobber step (success) 09:30:35 INFO - [mozharness: 2016-10-19 16:30:35.837897Z] Running read-buildbot-config step. 09:30:35 INFO - Running pre-action listener: _resource_record_pre_action 09:30:35 INFO - Running main action method: read_buildbot_config 09:30:35 INFO - Using buildbot properties: 09:30:35 INFO - { 09:30:35 INFO - "project": "", 09:30:35 INFO - "product": "firefox", 09:30:35 INFO - "script_repo_revision": "production", 09:30:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:30:35 INFO - "repository": "", 09:30:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:30:35 INFO - "buildid": "20161019080022", 09:30:35 INFO - "pgo_build": "False", 09:30:35 INFO - "basedir": "/builds/slave/test", 09:30:35 INFO - "buildnumber": 52, 09:30:35 INFO - "slavename": "t-yosemite-r7-0296", 09:30:35 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:30:35 INFO - "platform": "yosemite_r7", 09:30:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:30:35 INFO - "branch": "mozilla-central", 09:30:35 INFO - "repo_path": "mozilla-central", 09:30:35 INFO - "revision": "8b2d92343bcb398075c909c587ec020286528059", 09:30:35 INFO - "stage_platform": "macosx64", 09:30:35 INFO - "builduid": "6bbf0919cb204ba69eba80c88c34cd4c", 09:30:35 INFO - "slavebuilddir": "test" 09:30:35 INFO - } 09:30:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 09:30:35 INFO - Running post-action listener: _resource_record_post_action 09:30:35 INFO - [mozharness: 2016-10-19 16:30:35.841213Z] Finished read-buildbot-config step (success) 09:30:35 INFO - [mozharness: 2016-10-19 16:30:35.841353Z] Running download-and-extract step. 09:30:35 INFO - Running pre-action listener: _resource_record_pre_action 09:30:35 INFO - Running main action method: download_and_extract 09:30:35 INFO - mkdir: /builds/slave/test/build/tests 09:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:35 INFO - trying https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 09:30:35 INFO - Downloading https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:30:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 09:30:36 INFO - Downloaded 1199 bytes. 09:30:36 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 09:30:36 INFO - Using the following test package requirements: 09:30:36 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:30:36 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 09:30:36 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 09:30:36 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'jsshell-mac.zip'], 09:30:36 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 09:30:36 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 09:30:36 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 09:30:36 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 09:30:36 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 09:30:36 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 09:30:36 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 09:30:36 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:30:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:30:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:30:36 INFO - Fetch https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:30:37 INFO - Http code: 200 09:30:37 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 09:30:37 INFO - x-amz-cf-id: Nko-JWV2vje6adqBtz7NXqWdvMO4W1UrvA0qy3gVUoWCliFz2HgbQg== 09:30:37 INFO - x-amz-version-id: Hl.JtPupfZOMe_90uJRxIVIwEY_kBJiL 09:30:37 INFO - Expected file size: 16499838 09:30:37 INFO - Obtained file size: 16499838 09:30:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:30:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 09:30:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:30:44 INFO - Fetch https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 09:30:45 INFO - Http code: 200 09:30:45 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 09:30:45 INFO - x-amz-cf-id: 96S8Yb32_nwERDVXcV4ebMO8i6Wiv11Rr6vDqez7CEF4L00iyVSuWw== 09:30:45 INFO - x-amz-version-id: Hl.JtPupfZOMe_90uJRxIVIwEY_kBJiL 09:30:45 INFO - Expected file size: 16499838 09:30:45 INFO - Obtained file size: 16499838 09:30:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 09:30:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:30:51 INFO - Fetch https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 09:30:52 INFO - Http code: 200 09:30:52 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:30:52 INFO - x-amz-cf-id: crRkEobIwxSaCz4lqV6rGb01Ni3Sle0_qY_rh7UVaUn7nM9VzYiNhA== 09:30:52 INFO - x-amz-version-id: cFDC7RMuUPIKaLRriSbUkcn0Cl3uzUju 09:30:52 INFO - Expected file size: 14409028 09:30:52 INFO - Obtained file size: 14409028 09:30:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:30:52 INFO - trying https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:30:52 INFO - Downloading https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 09:30:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 09:30:55 INFO - Downloaded 111647814 bytes. 09:30:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:30:55 INFO - mkdir: /builds/slave/test/properties 09:30:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:30:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:30:55 INFO - Contents: 09:30:55 INFO - build_url:https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 09:30:56 INFO - Running post-action listener: _resource_record_post_action 09:30:56 INFO - Running post-action listener: set_extra_try_arguments 09:30:56 INFO - [mozharness: 2016-10-19 16:30:56.350883Z] Finished download-and-extract step (success) 09:30:56 INFO - [mozharness: 2016-10-19 16:30:56.351004Z] Running populate-webroot step. 09:30:56 INFO - Running pre-action listener: _resource_record_pre_action 09:30:56 INFO - Running main action method: populate_webroot 09:30:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:30:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:30:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:30:56 INFO - '--tppagecycles', 09:30:56 INFO - '7'], 09:30:56 INFO - 'tests': ['tsvgm']}}, 09:30:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:30:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:30:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:30:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:30:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:30:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['damp', 'tps']}, 09:30:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'tests': ['damp', 'tps']}, 09:30:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['dromaeo_dom']}, 09:30:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:30:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['basic_compositor_video']}, 09:30:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:30:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['a11yr', 09:30:56 INFO - 'ts_paint', 09:30:56 INFO - 'tpaint', 09:30:56 INFO - 'sessionrestore', 09:30:56 INFO - 'sessionrestore_no_auto_restore', 09:30:56 INFO - 'tabpaint']}, 09:30:56 INFO - 'other-e10s': {'tests': ['a11yr', 09:30:56 INFO - 'ts_paint', 09:30:56 INFO - 'tpaint', 09:30:56 INFO - 'sessionrestore', 09:30:56 INFO - 'sessionrestore_no_auto_restore', 09:30:56 INFO - 'tabpaint']}, 09:30:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:30:56 INFO - 'ts_paint', 09:30:56 INFO - 'tpaint', 09:30:56 INFO - 'sessionrestore', 09:30:56 INFO - 'sessionrestore_no_auto_restore', 09:30:56 INFO - 'tabpaint']}, 09:30:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:30:56 INFO - 'ts_paint', 09:30:56 INFO - 'tpaint', 09:30:56 INFO - 'sessionrestore', 09:30:56 INFO - 'sessionrestore_no_auto_restore', 09:30:56 INFO - 'tabpaint']}, 09:30:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['a11yr', 09:30:56 INFO - 'ts_paint', 09:30:56 INFO - 'tpaint', 09:30:56 INFO - 'sessionrestore', 09:30:56 INFO - 'sessionrestore_no_auto_restore', 09:30:56 INFO - 'tabpaint']}, 09:30:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['a11yr', 09:30:56 INFO - 'ts_paint', 09:30:56 INFO - 'tpaint', 09:30:56 INFO - 'sessionrestore', 09:30:56 INFO - 'sessionrestore_no_auto_restore', 09:30:56 INFO - 'tabpaint']}, 09:30:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['tsvgx', 09:30:56 INFO - 'tsvgr_opacity', 09:30:56 INFO - 'tart', 09:30:56 INFO - 'tscrollx', 09:30:56 INFO - 'cart']}, 09:30:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:30:56 INFO - 'tsvgr_opacity', 09:30:56 INFO - 'tart', 09:30:56 INFO - 'tscrollx', 09:30:56 INFO - 'cart']}, 09:30:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'talos_options': ['--disable-e10s'], 09:30:56 INFO - 'tests': ['tp5o']}, 09:30:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'tests': ['tp5o']}, 09:30:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'talos_options': ['--disable-e10s', 09:30:56 INFO - '--xperf_path', 09:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:56 INFO - 'tests': ['tp5n']}, 09:30:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:30:56 INFO - 'talos_options': ['--xperf_path', 09:30:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:30:56 INFO - 'tests': ['tp5n']}}, 09:30:56 INFO - 'talos.zip': {'path': '', 09:30:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:30:56 INFO - Running post-action listener: _resource_record_post_action 09:30:56 INFO - [mozharness: 2016-10-19 16:30:56.369781Z] Finished populate-webroot step (success) 09:30:56 INFO - [mozharness: 2016-10-19 16:30:56.369884Z] Running create-virtualenv step. 09:30:56 INFO - Running pre-action listener: _resource_record_pre_action 09:30:56 INFO - Running main action method: create_virtualenv 09:30:56 INFO - Creating virtualenv /builds/slave/test/build/venv 09:30:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:30:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:30:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:30:56 INFO - Using real prefix '/tools/python27' 09:30:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:30:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:00 INFO - Installing pip.................done. 09:31:00 INFO - Return code: 0 09:31:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:31:00 INFO - Reading from file tmpfile_stdout 09:31:00 INFO - Output received: 09:31:00 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:31:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:00 INFO - 'HOME': '/Users/cltbld', 09:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:00 INFO - 'LOGNAME': 'cltbld', 09:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:00 INFO - 'MOZ_NO_REMOTE': '1', 09:31:00 INFO - 'NO_EM_RESTART': '1', 09:31:00 INFO - 'PAGER': '/bin/cat', 09:31:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:00 INFO - 'PWD': '/builds/slave/test', 09:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:00 INFO - 'SHELL': '/bin/bash', 09:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:00 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:00 INFO - 'USER': 'cltbld', 09:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:00 INFO - 'XPC_FLAGS': '0x0', 09:31:00 INFO - 'XPC_SERVICE_NAME': '0', 09:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:31:00 INFO - Cleaning up... 09:31:00 INFO - Return code: 0 09:31:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:31:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:31:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:00 INFO - 'HOME': '/Users/cltbld', 09:31:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:00 INFO - 'LOGNAME': 'cltbld', 09:31:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:00 INFO - 'MOZ_NO_REMOTE': '1', 09:31:00 INFO - 'NO_EM_RESTART': '1', 09:31:00 INFO - 'PAGER': '/bin/cat', 09:31:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:00 INFO - 'PWD': '/builds/slave/test', 09:31:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:00 INFO - 'SHELL': '/bin/bash', 09:31:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:00 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:00 INFO - 'USER': 'cltbld', 09:31:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:00 INFO - 'XPC_FLAGS': '0x0', 09:31:00 INFO - 'XPC_SERVICE_NAME': '0', 09:31:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:00 INFO - Downloading/unpacking psutil>=3.1.1 09:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:04 INFO - Installing collected packages: psutil 09:31:04 INFO - Running setup.py install for psutil 09:31:04 INFO - building 'psutil._psutil_osx' extension 09:31: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 09:31: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 09:31: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 09:31:04 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:31:04 INFO - building 'psutil._psutil_posix' extension 09:31:04 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:31:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:31:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:31:04 INFO - ^ 09:31:04 INFO - 1 warning generated. 09:31:04 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 09:31:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:05 INFO - Successfully installed psutil 09:31:05 INFO - Cleaning up... 09:31:05 INFO - Return code: 0 09:31:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31: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 09:31: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 09:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:05 INFO - 'HOME': '/Users/cltbld', 09:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:05 INFO - 'LOGNAME': 'cltbld', 09:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:05 INFO - 'MOZ_NO_REMOTE': '1', 09:31:05 INFO - 'NO_EM_RESTART': '1', 09:31:05 INFO - 'PAGER': '/bin/cat', 09:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:05 INFO - 'PWD': '/builds/slave/test', 09:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:05 INFO - 'SHELL': '/bin/bash', 09:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:05 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:05 INFO - 'USER': 'cltbld', 09:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:05 INFO - 'XPC_FLAGS': '0x0', 09:31:05 INFO - 'XPC_SERVICE_NAME': '0', 09:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:31:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:31:08 INFO - Installing collected packages: mozsystemmonitor 09:31:08 INFO - Running setup.py install for mozsystemmonitor 09:31:08 INFO - Successfully installed mozsystemmonitor 09:31:08 INFO - Cleaning up... 09:31:08 INFO - Return code: 0 09:31:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31: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 09:31: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 09:31:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:08 INFO - 'HOME': '/Users/cltbld', 09:31:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:08 INFO - 'LOGNAME': 'cltbld', 09:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:08 INFO - 'MOZ_NO_REMOTE': '1', 09:31:08 INFO - 'NO_EM_RESTART': '1', 09:31:08 INFO - 'PAGER': '/bin/cat', 09:31:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:08 INFO - 'PWD': '/builds/slave/test', 09:31:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:08 INFO - 'SHELL': '/bin/bash', 09:31:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:08 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:08 INFO - 'USER': 'cltbld', 09:31:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:08 INFO - 'XPC_FLAGS': '0x0', 09:31:08 INFO - 'XPC_SERVICE_NAME': '0', 09:31:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:08 INFO - Downloading/unpacking jsonschema==2.5.1 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:31:11 INFO - warning: no files found matching '*.txt' 09:31:11 INFO - no previously-included directories found matching 'build' 09:31:11 INFO - no previously-included directories found matching 'dist' 09:31:11 INFO - no previously-included directories found matching '.git*' 09:31:11 INFO - Installing collected packages: jsonschema, functools32 09:31:11 INFO - Running setup.py install for functools32 09:31:11 INFO - warning: no files found matching '*.txt' 09:31:11 INFO - no previously-included directories found matching 'build' 09:31:11 INFO - no previously-included directories found matching 'dist' 09:31:11 INFO - no previously-included directories found matching '.git*' 09:31:11 INFO - Successfully installed jsonschema functools32 09:31:11 INFO - Cleaning up... 09:31:11 INFO - Return code: 0 09:31:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:31:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:31:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:11 INFO - 'HOME': '/Users/cltbld', 09:31:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:11 INFO - 'LOGNAME': 'cltbld', 09:31:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:11 INFO - 'MOZ_NO_REMOTE': '1', 09:31:11 INFO - 'NO_EM_RESTART': '1', 09:31:11 INFO - 'PAGER': '/bin/cat', 09:31:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:11 INFO - 'PWD': '/builds/slave/test', 09:31:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:11 INFO - 'SHELL': '/bin/bash', 09:31:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:11 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:11 INFO - 'USER': 'cltbld', 09:31:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:11 INFO - 'XPC_FLAGS': '0x0', 09:31:11 INFO - 'XPC_SERVICE_NAME': '0', 09:31:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:31:12 INFO - Cleaning up... 09:31:12 INFO - Return code: 0 09:31:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31: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 09:31: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 09:31:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:12 INFO - 'HOME': '/Users/cltbld', 09:31:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:12 INFO - 'LOGNAME': 'cltbld', 09:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:12 INFO - 'MOZ_NO_REMOTE': '1', 09:31:12 INFO - 'NO_EM_RESTART': '1', 09:31:12 INFO - 'PAGER': '/bin/cat', 09:31:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:12 INFO - 'PWD': '/builds/slave/test', 09:31:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:12 INFO - 'SHELL': '/bin/bash', 09:31:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:12 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:12 INFO - 'USER': 'cltbld', 09:31:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:12 INFO - 'XPC_FLAGS': '0x0', 09:31:12 INFO - 'XPC_SERVICE_NAME': '0', 09:31:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:12 INFO - Downloading/unpacking blobuploader==1.2.4 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:14 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:31:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31: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 09:31:16 INFO - Downloading docopt-0.6.1.tar.gz 09:31:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:16 INFO - Running setup.py install for blobuploader 09:31:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:31:16 INFO - Running setup.py install for requests 09:31:16 INFO - Running setup.py install for docopt 09:31:16 INFO - Successfully installed blobuploader requests docopt 09:31:16 INFO - Cleaning up... 09:31:17 INFO - Return code: 0 09:31:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31: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 09:31: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 09:31:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:17 INFO - 'HOME': '/Users/cltbld', 09:31:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:17 INFO - 'LOGNAME': 'cltbld', 09:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:17 INFO - 'MOZ_NO_REMOTE': '1', 09:31:17 INFO - 'NO_EM_RESTART': '1', 09:31:17 INFO - 'PAGER': '/bin/cat', 09:31:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:17 INFO - 'PWD': '/builds/slave/test', 09:31:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:17 INFO - 'SHELL': '/bin/bash', 09:31:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:17 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:17 INFO - 'USER': 'cltbld', 09:31:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:17 INFO - 'XPC_FLAGS': '0x0', 09:31:17 INFO - 'XPC_SERVICE_NAME': '0', 09:31:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-AqOBC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-zkOtot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Frni15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Do9IY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-PrV6RF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-It_HUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-FGL37W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-5TYVWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-OEEkNW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-hHrKjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Ie62qA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-n8e402-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-RETNXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-YkSQH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-uM0a2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-ZhQTTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-pNqqvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:19 INFO - Running setup.py install for manifestparser 09:31:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:31:19 INFO - Running setup.py install for mozcrash 09:31:19 INFO - Running setup.py install for mozdebug 09:31:19 INFO - Running setup.py install for mozdevice 09:31:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:31:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:31:19 INFO - Running setup.py install for mozfile 09:31:19 INFO - Running setup.py install for mozhttpd 09:31:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:31:19 INFO - Running setup.py install for mozinfo 09:31:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Running setup.py install for mozInstall 09:31:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Running setup.py install for mozleak 09:31:20 INFO - Running setup.py install for mozlog 09:31:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Running setup.py install for moznetwork 09:31:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Running setup.py install for mozprocess 09:31:20 INFO - Running setup.py install for mozprofile 09:31:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:31:20 INFO - Running setup.py install for mozrunner 09:31:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:31:21 INFO - Running setup.py install for mozscreenshot 09:31:21 INFO - Running setup.py install for moztest 09:31:21 INFO - Running setup.py install for mozversion 09:31:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:31:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:21 INFO - Cleaning up... 09:31:21 INFO - Return code: 0 09:31:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:21 INFO - 'HOME': '/Users/cltbld', 09:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:21 INFO - 'LOGNAME': 'cltbld', 09:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:21 INFO - 'MOZ_NO_REMOTE': '1', 09:31:21 INFO - 'NO_EM_RESTART': '1', 09:31:21 INFO - 'PAGER': '/bin/cat', 09:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:21 INFO - 'PWD': '/builds/slave/test', 09:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:21 INFO - 'SHELL': '/bin/bash', 09:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:21 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:21 INFO - 'USER': 'cltbld', 09:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:21 INFO - 'XPC_FLAGS': '0x0', 09:31:21 INFO - 'XPC_SERVICE_NAME': '0', 09:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:21 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-8xz9CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:21 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-jAfRD0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31: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)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-5iPe8o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31: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)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-sbBIGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31: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)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-TPo1yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31: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)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Dxqq1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-2xnmWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-9GvRMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-6T2oHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-bkCSqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-VjaaOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31: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)) 09:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-i9MDyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31: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)) 09:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-kEbsbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31: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)) 09:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-azrSYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31: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)) 09:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-dpUpze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31: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)) 09:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-4eFpZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:31:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-hTDiQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:31:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:26 INFO - Downloading blessings-1.6.tar.gz 09:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:26 INFO - Installing collected packages: blessings 09:31:26 INFO - Running setup.py install for blessings 09:31:26 INFO - Successfully installed blessings 09:31:26 INFO - Cleaning up... 09:31:26 INFO - Return code: 0 09:31:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:31:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:26 INFO - Reading from file tmpfile_stdout 09:31:26 INFO - Current package versions: 09:31:26 INFO - blessings == 1.6 09:31:26 INFO - blobuploader == 1.2.4 09:31:26 INFO - docopt == 0.6.1 09:31:26 INFO - functools32 == 3.2.3-2 09:31:26 INFO - jsonschema == 2.5.1 09:31:26 INFO - manifestparser == 1.1 09:31:26 INFO - mozInstall == 1.12 09:31:26 INFO - mozcrash == 0.17 09:31:26 INFO - mozdebug == 0.1 09:31:26 INFO - mozdevice == 0.48 09:31:26 INFO - mozfile == 1.2 09:31:26 INFO - mozhttpd == 0.7 09:31:26 INFO - mozinfo == 0.9 09:31:26 INFO - mozleak == 0.1 09:31:26 INFO - mozlog == 3.4 09:31:26 INFO - moznetwork == 0.27 09:31:26 INFO - mozprocess == 0.23 09:31:26 INFO - mozprofile == 0.28 09:31:26 INFO - mozrunner == 6.12 09:31:26 INFO - mozscreenshot == 0.1 09:31:26 INFO - mozsystemmonitor == 0.3 09:31:26 INFO - moztest == 0.7 09:31:26 INFO - mozversion == 1.4 09:31:26 INFO - psutil == 3.1.1 09:31:26 INFO - requests == 1.2.3 09:31:26 INFO - wsgiref == 0.1.2 09:31:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:26 INFO - 'HOME': '/Users/cltbld', 09:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:26 INFO - 'LOGNAME': 'cltbld', 09:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:26 INFO - 'MOZ_NO_REMOTE': '1', 09:31:26 INFO - 'NO_EM_RESTART': '1', 09:31:26 INFO - 'PAGER': '/bin/cat', 09:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:26 INFO - 'PWD': '/builds/slave/test', 09:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:26 INFO - 'SHELL': '/bin/bash', 09:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:26 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:26 INFO - 'USER': 'cltbld', 09:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:26 INFO - 'XPC_FLAGS': '0x0', 09:31:26 INFO - 'XPC_SERVICE_NAME': '0', 09:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31: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)) 09:31:27 INFO - Cleaning up... 09:31:27 INFO - Return code: 0 09:31:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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')]} 09:31:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:31: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 0x1101a2490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110118570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6c3473460>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, '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.HODvUeb7js/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.JZOO5JPn70/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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 09:31: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 09:31: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 09:31:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:31:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:31:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:31:27 INFO - 'HOME': '/Users/cltbld', 09:31:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:31:27 INFO - 'LOGNAME': 'cltbld', 09:31:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:27 INFO - 'MOZ_NO_REMOTE': '1', 09:31:27 INFO - 'NO_EM_RESTART': '1', 09:31:27 INFO - 'PAGER': '/bin/cat', 09:31:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:31:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:27 INFO - 'PWD': '/builds/slave/test', 09:31:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:31:27 INFO - 'SHELL': '/bin/bash', 09:31:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:31:27 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:31:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:31:27 INFO - 'USER': 'cltbld', 09:31:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:31:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:31:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:27 INFO - 'XPC_FLAGS': '0x0', 09:31:27 INFO - 'XPC_SERVICE_NAME': '0', 09:31:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:31:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:31:27 INFO - Cleaning up... 09:31:27 INFO - Return code: 0 09:31:27 INFO - Running post-action listener: _resource_record_post_action 09:31:27 INFO - Running post-action listener: _start_resource_monitoring 09:31:27 INFO - Starting resource monitoring. 09:31:27 INFO - [mozharness: 2016-10-19 16:31:27.415998Z] Finished create-virtualenv step (success) 09:31:27 INFO - [mozharness: 2016-10-19 16:31:27.416970Z] Running install step. 09:31:27 INFO - Running pre-action listener: _resource_record_pre_action 09:31:27 INFO - Running main action method: install 09:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:27 INFO - Reading from file tmpfile_stdout 09:31:27 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:31:27 INFO - Reading from file tmpfile_stdout 09:31:27 INFO - Output received: 09:31:27 INFO - Usage: mozinstall [options] installer 09:31:27 INFO - Options: 09:31:27 INFO - -h, --help show this help message and exit 09:31:27 INFO - -d DEST, --destination=DEST 09:31:27 INFO - Directory to install application into. [default: 09:31:27 INFO - "/builds/slave/test"] 09:31:27 INFO - --app=APP Application being installed. [default: firefox] 09:31:27 INFO - mkdir: /builds/slave/test/build/application 09:31:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:31:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:32:01 INFO - Reading from file tmpfile_stdout 09:32:01 INFO - Output received: 09:32:01 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:32:01 INFO - Running post-action listener: _resource_record_post_action 09:32:01 INFO - [mozharness: 2016-10-19 16:32:01.808138Z] Finished install step (success) 09:32:01 INFO - [mozharness: 2016-10-19 16:32:01.808352Z] Running run-tests step. 09:32:01 INFO - Running pre-action listener: _resource_record_pre_action 09:32:01 INFO - Running main action method: run_tests 09:32:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:32:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:32:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:32:01 INFO - 2016-10-19 09:32:01.822 screenresolution[1962:13448] starting screenresolution argv=screenresolution get 09:32:01 INFO - 2016-10-19 09:32:01.825 screenresolution[1962:13448] Display 0: 1600x1200x32@60 09:32:01 INFO - 2016-10-19 09:32:01.831 screenresolution[1963:13450] starting screenresolution argv=screenresolution list 09:32:01 INFO - Available Modes on Display 0 09:32:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:32:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:32:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:32:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:32:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:32:02 INFO - Intel Iris: 09:32:02 INFO - Chipset Model: Intel Iris 09:32:02 INFO - Type: GPU 09:32:02 INFO - Bus: Built-In 09:32:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:32:02 INFO - Vendor: Intel (0x8086) 09:32:02 INFO - Device ID: 0x0a2e 09:32:02 INFO - Revision ID: 0x0009 09:32:02 INFO - Displays: 09:32:02 INFO - Display: 09:32:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:32:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:32:02 INFO - Display Serial Number: 1600x1200 60 09:32:02 INFO - Main Display: Yes 09:32:02 INFO - Mirror: Off 09:32:02 INFO - Online: Yes 09:32:02 INFO - Rotation: Supported 09:32:02 INFO - Return code: 0 09:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:32:02 INFO - Python 2.7.3 09:32:02 INFO - Return code: 0 09:32:02 INFO - grabbing minidump binary from tooltool 09:32:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:02 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ffb6d30>, '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 0x10fddcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ffaeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:32:02 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:32:02 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:32:02 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:32:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:32:02 INFO - Return code: 0 09:32:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:32:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:32:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:32:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:32:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:32:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0296', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0296 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:32:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HODvUeb7js/Render', 09:32:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:02 INFO - 'HOME': '/Users/cltbld', 09:32:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:02 INFO - 'LOGNAME': 'cltbld', 09:32:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:32:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:02 INFO - 'MOZ_NO_REMOTE': '1', 09:32:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:32:02 INFO - 'NO_EM_RESTART': '1', 09:32:02 INFO - 'PAGER': '/bin/cat', 09:32:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:02 INFO - 'PWD': '/builds/slave/test', 09:32:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:32:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:02 INFO - 'SHELL': '/bin/bash', 09:32:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JZOO5JPn70/Listeners', 09:32:02 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 09:32:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:02 INFO - 'USER': 'cltbld', 09:32:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:02 INFO - 'XPC_FLAGS': '0x0', 09:32:02 INFO - 'XPC_SERVICE_NAME': '0', 09:32:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0296', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:32:02 INFO - mozversion application_buildid: 20161019080022 09:32:02 INFO - mozversion application_changeset: 8b2d92343bcb398075c909c587ec020286528059 09:32:02 INFO - mozversion application_display_name: Nightly 09:32:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:32:02 INFO - mozversion application_name: Firefox 09:32:02 INFO - mozversion application_remotingname: firefox 09:32:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:32:02 INFO - mozversion application_vendor: Mozilla 09:32:02 INFO - mozversion application_version: 52.0a1 09:32:02 INFO - mozversion platform_buildid: 20161019080022 09:32:02 INFO - mozversion platform_changeset: 8b2d92343bcb398075c909c587ec020286528059 09:32:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:32:02 INFO - mozversion platform_version: 52.0a1 09:32:02 INFO - using testdate: 1476894722 09:32:02 INFO - actual date: 1476894722 09:32:02 INFO - starting webserver on 'localhost:52096' 09:32:02 INFO - SUITE-START | Running 2 tests 09:32:02 INFO - TEST-START | dromaeo_css 09:32:02 INFO - operating with platform_type : mac_ 09:32:02 INFO - Initialising browser for dromaeo_css test... 09:32:02 INFO - TEST-INFO | started process 1973 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpdlOEpt/profile http://localhost:52096/getInfo.html) 09:32:04 INFO - PROCESS | 1973 | __metrics Screen width/height:1600/1200 09:32:04 INFO - PROCESS | 1973 | colorDepth:24 09:32:04 INFO - PROCESS | 1973 | Browser inner width/height: 1024/689 09:32:04 INFO - PROCESS | 1973 | __metrics 09:32:05 INFO - PROCESS | 1973 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:32:05 INFO - PROCESS | 1973 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:32:05 INFO - TEST-INFO | 1973: exit 0 09:32:05 INFO - Browser initialized. 09:32:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:05 INFO - TEST-INFO | started process 1975 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpdlOEpt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:17 INFO - PROCESS | 1975 | RSS: Main: 231710720 09:32:17 INFO - PROCESS | 1975 | 09:33:09 INFO - PROCESS | 1975 | 1476894789282 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] 09:35:21 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52096/tests/dromaeo/cssquery-ext.html) 09:35:24 INFO - PROCESS | 1975 | RSS: Main: 438603776 09:35:24 INFO - PROCESS | 1975 | 09:38:27 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-ext.html (next: http://localhost:52096/tests/dromaeo/cssquery-jquery.html) 09:38:28 INFO - PROCESS | 1975 | RSS: Main: 369467392 09:38:28 INFO - PROCESS | 1975 | 09:41:30 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52096/tests/dromaeo/cssquery-mootools.html) 09:41:30 INFO - PROCESS | 1975 | RSS: Main: 343248896 09:41:30 INFO - PROCESS | 1975 | 09:44:33 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52096/tests/dromaeo/cssquery-prototype.html) 09:44:33 INFO - PROCESS | 1975 | RSS: Main: 343760896 09:44:33 INFO - PROCESS | 1975 | 09:47:37 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52096/tests/dromaeo/cssquery-yui.html) 09:47:37 INFO - PROCESS | 1975 | RSS: Main: 331075584 09:47:37 INFO - PROCESS | 1975 | 09:50:40 INFO - PROCESS | 1975 | Cycle 1(1): loaded http://localhost:52096/tests/dromaeo/cssquery-yui.html (next: http://localhost:52096/tests/dromaeo/cssquery-dojo.html) 09:50:41 INFO - PROCESS | 1975 | RSS: Main: 580567040 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | __start_tp_report 09:50:41 INFO - PROCESS | 1975 | _x_x_mozilla_page_load 09:50:41 INFO - PROCESS | 1975 | _x_x_mozilla_page_load_details 09:50:41 INFO - PROCESS | 1975 | |i|pagename|runs| 09:50:41 INFO - PROCESS | 1975 | |0;dojo.html;2799.5940588614653;3290.161008942719;3294.357600267949;3324.6675332466743;3355.2618423946737;5548.361938377077;5621;5621.606487545873;5715.657060576368;5735.369109397968;5602.635828671134;5623.240862483563;5710.942890571093;5715.457031582004;5735.168400581913;4226.239276930151;5067.74661266937;5121.820736274231;5153.69077855328;5167.431582525938;5143.27994080829;5241.3186285782795;5252.107141785906;5261.921071183935;5306.257124002643;5071.492850714936;5201.687898726089;5223.138182199932;5224.346956630421;5311.415744268127;5108.233764935252;5169.793208271664;5171.612129090333;5172.32759741235;5185.351831021122;5112.386513618352;5139.177731562932;5150.150225212836;5157.6647517911215;5169.379674439054;5531.502164805147;5619.915701264485;5654.547636189136;5658.207850900877;5666.46168613981;6096.163860440878;6175.907361389583;6181.96909015452;6201.10084037812;6225.595336303126;6274.749010039593;6278.529110316745;6295.307516173218;6295.527835412362;6297.118403423525;5615.550755939515;5640.859625968059;5672.971635141798;5701.543876489954;5721.141828725725;6203.906941395882;6317.873642527124;6322.71547780351;6342.270638876496;6345.936540634627;6042.093685947143;6045.425684559959;6058.485028772516;6059.909101363483;6065.54508411862;6061.302950160788;6107.735039974563;6138.723757430837;6197.597156184834;6199.876002479925;6036.245469316335;6077;6094.207752992172;6105.053716673922;6118.847028824315;6093.6554992613665;6105.511559075263;6118.174046503754;6137.53759154353;6144.771045790771;4881.072596206709;4902.730349830794;4906.509349065136;4910.975445122823;4960.479149689303;4312;4363.956360436418;4437.29003359461;4440.378347031418;4447.710898791568;5523;5595.272614560081;5603.3836278009385;5719.914201286984;5743;6125.571219981323;6146;6152.230971128609;6240.31356550779;6255.155554000243;5651.463111004448;5696.23100881384;5710.428957104339;5733.512651424592;5761.366249712528;5255.343082114736;5372.8656783579945;5379.4351593082165;5384.78460861569;5394.757235924393;6220.315765265907;6226.034964580497;6247.5001999840815;6270.843228919313;6281.089242059968;6240.781572644935;6246.281677607133;6249.687515624109;6255.468285195628;6261.749530018748;6277.686115694289;6288.339724328879;6305.369463053658;6339.3343698912795;6348.904766428415;5940.584159108821;5988.041913293852;5994.250718660168;6095.481884039907;6128.846778830565;6098.038923863867;6145.494353883327;6161.876762464815;6204.348543402878;6210.906836397548;5968.940310596839;5979.5814292999075;5981.742870481597;5994.820155395345;6051.485623721856;5836.591438599257;5870.119482077552;5911.172435858897;5973.641581505123;5981.940180598138;5748.252727145445;5808.477237048686;5813.709314534341;5816.098504731774;5821.912671309849;5965.91051134242;5968.940310596839;5971.970140149271;5972.970135149297;5980.9401905980385;4671.883202919954;5763.077907534775;5819.156222347651;5823.126531020381;5823.563232757476 09:50:41 INFO - PROCESS | 1975 | |1;ext.html;456.9086182763447;471.5638034817795;472.1006482650551;472.4613940108277;542.6960901894942;40856.59143408565;42325.36511952323;42423.36364954528;42502.362464563055;44046.77976610113;43175.56824431755;43582.46263060543;43592;43625.34561981565;43645.345319820226;9507.477088760133;9730.367526110815;9733.659321923735;9751.317407781458;9755.170810481117;9586.808263834719;9687.031296870327;9694.36986595869;9702.466364349957;9714.757131071745;9705;9751.3661611995;9769.902300977006;9773.706788796311;9781.46201958892;9600.519974001307;9627.759306017335;9644.75888102796;9645.614175432975;9646.083622055894;9417.952910235474;9454.4800035998;9567.37812042215;9569.90430095697;9579.425234485883;40304.79847600772;40602.78191654255;40699.98250043743;40743.7962810187;40764.79617601893;3366.4277072897667;3475.0096222576444;3546.7871927684423;3715.479832823407;3955.0507878109047;27977.44045119086;29291;30304.939327123666;31800.522992154903;32054.519182212287;3187.199361961953;3229.40256052631;3232.595925509311;3301.752368572367;3318.634950155481;467614;468612;469287.99999999657;470169;470930;58434.415655842895;58720.18318809264;58798.11802822961;58819.705901471076;58833.70583147142;34750.30499389998;35155.47266791;35365.29269414649;36352.45471317932;36394;16284.592885177964;16459;16461.34154633825;16480.17599120063;16502.17489125539;12536.81194782079;12634.431450584745;12640.178388404907;12640.810387844005;12653.304068276333;19120.61758764817;19206.934984520125;19211.423657290303;19245.518862028563;19418.320358787376;7599.354054905284;7650.770476885702;7693.192214817475;7723.9227607723205;7730.690772369042;864.5590748718199;976.7948730766618;982.6020461713018;999.5951639585979;1061.6708820265742;25754;29917.551236731466;29974.100776976724;30524.236894077825;30660;891.1222445890793;968.2979839616363;984.2372161574837;1079.3523885668692;1105.2649987758211;13877.583672489842;15035.54893353201;15633.530994069968;15655.921720391325;15675.529734107995;187396;187863;187978;188537;646341;54143.45856541463;58407;58800;58844.52888677732;58952.41047589469;1131.6491887514896;1233.5374234662002;1277.8338815953866;1389.1595584671331;1399.8460169381563;30303.545446818756;30343.696563034086;31106.84446577843;31197;31200.68799311978;41832.79083604684;50244.995100098524;50722;50746.2388064172;50913;529480;531321;533760;534115.3059642893;534691;26536.336591585365;26620.86689566617;27174.456510870066;27259;28033.738481767963;46974.76512617415;47234.76382618065;47933.28100078571;47973.520264796905;48132.27801583049;38200.61799381971;38531;38544;40021.79989100036;40100.598994009684;38485.615143848205;38858.4171237426;38873;40274.59725402708;40525.594744053364;37828;38400.42399363956;38648.42027369648;38727.80636096802;38825.805870970464;31949.68050319467;34133;34328.656713432545;34517.482237766955;35087.71929824553;25263.62104568396;25348.493030139663;25375.61936570916;25642.871785640953;26068.73931260739 09:50:41 INFO - PROCESS | 1975 | |2;jquery.html;356.24653857092255;370.342641810786;374.30005888987597;382.2278996427218;405.5214846481151;14705.779413308795;14928.925355373221;15741.527754167393;20234;20645.277415290468;19633.705494417594;20161.891095989715;20692.793072069275;20832.583348333024;20922;4943.629227807911;5580.972095139518;5878.676672782995;5883.646981181121;5884.558658100638;4999;5262.578993680497;5826.21346118275;5875.206847075654;5877.14781356703;5659.773609055633;5668.489835914787;5818.970905145468;5824.534037277029;5827.300723913137;5669.23465332179;5793.449622285876;5801.071828507461;5803.245578074865;5803.506701930341;4834.975825120852;4982.053409852153;5063.569596584295;5065.569426598743;5080.974595127001;25689.614655780177;25765.098221562344;25775.613365799527;25809.580473073973;26020.479590408086;2463.531928933497;2968.821870687744;3084.599002129731;3127.8279694616785;3155.826429546374;10853.5115919783;15735.763963540556;15739.449119280885;15758.606034849221;15844.20778961059;1748.7918878238197;1895.5261184703825;1896.838768704648;1914.525815122348;1931.777845547766;73066.63466682633;77396;109836.90163098427;110727.89272107257;112498.43750781275;7794.883076753853;10410.323328983592;10447.634332798316;10724.195685323632;10919.781604367869;13348.199108053548;13358.866411335957;13379.197248165141;13382.13016153947;13409.597712068653;8037.35701143907;8254.174582541698;8342.998840139222;8428.410011299273;8464.873026904601;8315.584220788936;8327.364609446457;8328.292095171857;8494.957525212334;8550.78623034429;5298.549623282064;5379.946200538023;6526.706298216592;6548.410643042149;6650.70071846768;1840.6962851129413;1859.9907000464912;1868.0753027251326;1874.8218919202654;1902.286642509059;845.8477474054606;883.1742320929951;957.760559860035;998.605550807427;1031.2368847053276;21098.789012109683;22287.442813929458;22348.21781237649;22417.551648966928;22514.437139071655;925.6806401791371;926.749777560055;977.9853302200472;992.8163289791412;1010.8382658774708;9485.004074572209;11065.557377704801;11138;11722.179447438597;11916.702082447835;534359;553496;553676;554515;563903;65418;79687.20312796914;102961.48519257506;110327.69016929505;115203;864.2049314630555;937.1518775508176;941.0448394879203;1012.8733908261468;1013.6756238003916;14403.855961440251;18994.715079273545;19545.902270488557;19585.216591336186;19752.506187345432;36172.27655446929;48988.510114898396;49269.260961084896;49309.2603610939;50134;69398;69826.95259571212;70334.29665703482;70634;72384;6964.338387853146;7157.1769246537315;7287.635618219174;7419.517731347445;7761.301482866569;10243.282970192313;10515.421651809223;11055.502502387573;12460.190087644274;12932.224066556037;9705.320627556004;9815.2147828175;10314.535845886803;11115.44422778874;11189.496472658913;10455.895441045797;10746.355218686904;10836.187285953427;10845.295055821347;11278.718032049264;10892.564297428014;11133.220674552704;11412.71468213268;11448.484818183368;11515.712107197387;6520.087187793618;7116.537425067354;7235.782926512213;7287.1984081752025;7472.589007604634;9204.355695101547;10775.838362424727;11064.336139831636;11109.611163609557;11112.111031117653 09:50:41 INFO - PROCESS | 1975 | |3;mootools.html;1539.3611651164763;1555.7277476441623;1784.1079460269866;1898.0794314757331;1927.219476112174;8154.3884208684285;8595.95702021489;8605.225529702326;8619.655213791448;8623.353248506355;7796.727114550992;8049.758507244777;8219;8403.41176117672;8583.356248281372;2312.7109111361124;2368.95262094758;2370.679958205646;2374.750651181627;2379.8453100548495;2078.5011597216712;2295.988520057397;2360.563295790276;2385.5586716457424;2390.689210402645;2352.529494101178;2365.858048517086;2367.183321753992;2376.2039716694926;2378.7502312257225;2321.0483701682397;2336.4742932840145;2343.203310874294;2345.636426353918;2359.197872723282;2334.253039027495;2335.9649605255936;2338.427085364097;2343.742188359279;2348.072511358021;8654.956725216334;8706.825863482694;8715.694950676696;8720.345974051908;8723.345749068782;5109;5176.249443830661;5308.097623404031;5310.814121505768;5321.9201711973965;3426.58880934287;3508.473728940654;3605.47720580517;3607.3146102240753;3627.564692236922;986.9506524673809;1042.1350279268265;1077.0414331245197;1083.3716444462193;1096.5120521367994;11252.099832013419;11333.603323883624;11473.885261147365;11474.196806223568;11483.368414737186;4539.773011349419;4580.198465268565;4695.460022097434;4792.784324705397;4798.256270278112;9974.301798874008;9974.451405172786;9982.950085249528;9986.500674966223;9994.450305233282;5315.495027972336;5332.9466705333225;5334.093204155303;5343.278657381282;5345.1714984177515;4354.259775838115;4451.821927122879;4521.321801729701;4822.903541929142;4875.098106850173;3622.293652737691;3644.3986742187244;3879.3792993120965;3961.7028722845325;3975.5626881043063;1151.1826603111717;1275.222114510148;1277.8977681785434;1297.6755811047237;1313.90802643814;806.4435539477741;838.980638524196;849.609179777297;896.5158814240237;920.9033051529627;5404.756785944642;5766.336871259775;5831.88336233273;5886.381929897385;6018.668973206516;876.9446968681266;891.772597987509;909.0909090909091;911.3711539038175;947.2232769129248;3814.809259537012;3958.722889397772;4055.858044968412;4059.106996460774;4073.5315438724333;10500.684979450476;10587.523561439753;10707.089897358812;10711.678649640524;10712.625058122929;10651.041406273473;10665.680029599125;10668.786624267472;10670.41312727792;10670.786584268426;7986.7603971880935;8063.435559510778;8158.510489370657;8259.256666900008;8269.255766981001;4700.858974230779;5661.603687741818;5799.159121927212;5834;5872.471477567039;9665.226781857575;9887.060729230712;9907.702768916944;9930.652427165014;9934.850977235492;8722.563871806258;9298.860517092384;10157.746056348355;10181.134603558781;10183.643572474928;6097.969510152599;6840.828979275558;7083.043789088407;7088.822779430556;7531.133919599316;6912.343327383891;7924.881126783218;8075.192480751878;8298.21166989135;8315.126911674188;7286.7085316586745;7401.519696060917;7422.925770742439;7481;7549.943007978777;6254.781082662085;7244.166920804175;7257.419406447577;7273.781786546412;7393.8151546211775;6608.8347791305605;6815.591064536144;6909.343612356818;6965.895511567229;6966.79099627012;4814.398200224972;4846.103470857903;4882.633802464758;4915.139850526215;4998.050370429607;4276.444062271885;4906.6320025997475;4915.188993816123;4976.477469865757;4978.655762943912 09:50:41 INFO - PROCESS | 1975 | |4;prototype.html;248.89421995651844;273.237666909323;299.86655938107543;312.28486765307434;316.63903150408527;4309.612134907858;4409.0900005996045;5223.6343455958095;5229.686218826868;5238.816641417541;3919.608538968661;4094.877153685387;4327.783610819462;5048.873778155548;5173.344529750481;3927.4894263745814;3951.881443556698;3972.36442169253;3980.9402858956996;4000.7599544027307;3277.2953814929783;3608.2242317901646;3955.288048151346;3986.3422535281643;4019.593142400166;3703.7962912039825;3921.490206273195;3950.762954222756;3951.3480275754464;3953.327934251184;3383.729301655886;3883.3010058189516;3912.4522566840665;3917.8628747993826;3921.1961547882615;3369.4103531881824;3373.9493907591404;3374.6794054564775;3387.491876218562;3388.8477917508167;4949.232868905326;5014.448410674823;5026.019926114409;5047.141985862412;5083.466236045236;4327.2643650579475;4422.358757980107;4469.888252793706;4478.932816007762;4482.7448314472;4476.641868650533;4683.718976861399;5395.73379180745;5399.1091469907415;5433.375161856358;3533.0460775590705;3588.6411358864166;3680.7975561344115;3702.426123950792;3708.4808126862263;5212.582993360522;5301.575873930076;5496.167960656049;5643.915341269884;5647.604667673265;3149.2441813964483;3319.68462996015;3716.962830371716;3743.970408137784;3778.263238668433;3192.824394658316;3211.935761284808;3765.9246815064093;3771.226898485859;3785.2240290740333;3518.3491054155065;3776.4335349697217;3859.363205071188;4384.56154384559;4458.398116254264;4728.739919304402;5180.585553155738;5248.790048398021;5466.480684334982;5506.697131657797;1124.8987591116838;1198.8801119887942;1283.3903895649678;1308.7436061381181;1315.1451556488169;817.7751118442476;837.0206857976183;840.6133178737849;841.5750046226739;841.6507149532875;4966.925496117561;5067.341245638044;5132.486751324912;5260.947390526122;5299.615173172088;5254.868628284247;5635;5654.321481422174;5681.971590142023;5689.630174038674;4541.341505481752;4948.554630083309;5113.463086375951;5210.140326846028;5306.071437498423;2466.654668346433;2481.9379515512255;2872.5834753960557;2928.238657948906;2953.9113826585235;5475.616706830484;5731.168980497804;5736.741846616829;5740.942590574041;5778.94221057784;5668.214512428572;5719.7426115824055;5726.770929162787;5770.720565376737;5796.971015144897;5124.538791508782;5419.539339156137;5489.780408783604;5722.4277572242445;5760.53915686744;4673.7429441381055;4915.827946021872;5241.6068794839775;5605.691686957257;5657.660540367591;5122.846314610568;5462.34647140208;5663.4053424391495;5667.498112999976;5669.489745922887;5815.678654031513;5827.329857066322;5839.051279104195;5845.843244648013;5874.500667443144;3196.6504619105403;3300.636929937657;3564.3405969895653;3737.794421306854;3838.3858582627763;4703.247480403119;5090.49095090488;5271.262023316815;5647.5034115960125;5669.886602268014;5518.310211223597;5521.585881058856;5537.8061767837935;5538.6399884007415;5565.076620982279;4523.7964291606295;5240.244041679613;5350.652207606493;5486.31421072366;5489.937446289797;4465.59809617136;5183.196604526304;5333.759980800795;5388.838334849961;5392.622516423813;4587.449506059294;5369.704666243394;5437.755301011385;5519.862003449946;5523.696196709219;5413.296271484682;5413.512783849473;5415.268938693226;5456.781728730806;5462.9726851365485 09:50:41 INFO - PROCESS | 1975 | |5;yui.html;550.2324257660564;718.9928100718992;725.2529894208967;756.1870988687159;829.2826704900264;15115.546533603996;15854.2072896355;15875.60310992223;15881.523554293375;15885.602859928493;14267.215303158322;14375.209363485004;14390.352434140463;14394.208318542476;14403.495877644285;680.8910574308112;708.9149302083757;854.5897968974896;860.1398601398602;905.4024343933006;887.4364778365752;891.3092353426082;895.6014573514789;896.7847716548014;897.6768363389175;900.6712549919265;950.7337945375272;951.8714973478561;952.9618815247381;953.208836665566;735.5035351138014;757.2427572427572;758.2190343945745;763.6563546404141;947.313197931501;563.5519761789387;668.4017804065383;682.5836239893661;691.0636088100651;694.1080711286023;15018.924905375512;15052.172130532816;15063.945523813338;15356.155411452366;15379.461718839899;13820.170789752647;14037.438502459889;14041.368138433794;14114.576562703136;14327.570172894726;10489.947550262275;12876.227426354355;13152.21086734799;13187.802182967263;13615.795763063563;4603.769811509411;4636.884077898046;4649.790759415834;4838.709677419366;4841.837958889876;112766;115963.42018289938;116377;117930.99999999914;118532.40733796362;11212.887871121184;11249;11289.322640641587;11398;11580.305181689126;22124.55750884973;22239.44401389978;22403.991820368123;23005.539889202457;23052.193173238855;7712.9614351927885;7866.252705992922;8003.959980200062;8011.519308841488;8121.187881211949;4378.737275763465;4456.487503937024;4463.66522510813;4504.121696269196;4508.18852606534;3405.506201600754;3517.314123745845;3517.4547945068557;3520.3663340598937;3521.559805024372;640.1517988665038;641.4419455074116;645.9128017717547;651.0397164182792;676.2763842688374;540.5945540844367;603.0923460192382;648.3224283708255;689.5450599235609;700.94042006429;7977.680892764341;9266.490343031062;9490.430574165572;9565.569549370295;9639.277054220962;583.6643929740417;631.7378288010516;649.2695717318018;682.7030241844814;683.1631251716707;3764.5482542095124;4357.411749413852;4599.896024954054;4620.630349572026;4677.924077462203;152835;154011;156814;158979;161972.19013905092;130559;133849;133982;134937;139204;89247.55376223077;112030;116096;118857;119972.80027199791;8890.33322500828;8919.509426981578;8924.241439477717;8968.68609598661;9024.232940200156;47288.763556182;61011.694941525006;63075.36924630879;68712.31287687259;70125.64937175282;70852;79161;96096.07807843664;101907.49046254721;101992;12052.035837132833;12511.499540018298;12548.121631485708;12551.748965020832;12804.487820487077;12930.159539629894;13281;13514.459421623025;13549.187048777105;13914.582562523141;8693.39146259781;12547.74904501923;12562.932150767287;12611.495540178657;12908.741825163257;12180.269183848997;12226.633201003984;12757.936210318889;12936.482540698267;12936.935315323362;9758.06692783891;10350.896491034993;12222.266664000188;12458.377081145725;12629.11596188258;10279.588816447558;10296.17630589536;10463.895361046292;10576.418296993432;10593.36439813583;9379.296552758708;9656.95171524138;9682.70951871445;10523.94738026305;10684.198685098803 09:50:41 INFO - PROCESS | 1975 | __end_tp_report 09:50:41 INFO - PROCESS | 1975 | __start_cc_report 09:50:41 INFO - PROCESS | 1975 | _x_x_mozilla_cycle_collect,2625 09:50:41 INFO - PROCESS | 1975 | __end_cc_report 09:50:41 INFO - PROCESS | 1975 | __startTimestamp1476895841230__endTimestamp 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | ------- Summary: start ------- 09:50:41 INFO - PROCESS | 1975 | Number of tests: 6 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | [#0] dojo.html Cycles:165 Average:5672.14 Median:5821.91 stddev:653.71 (11.2%) stddev-sans-first:615.65 09:50:41 INFO - PROCESS | 1975 | Values: 2799.6 3290.2 3294.4 3324.7 3355.3 5548.4 5621.0 5621.6 5715.7 5735.4 5602.6 5623.2 5710.9 5715.5 5735.2 4226.2 5067.7 5121.8 5153.7 5167.4 5143.3 5241.3 5252.1 5261.9 5306.3 5071.5 5201.7 5223.1 5224.3 5311.4 5108.2 5169.8 5171.6 5172.3 5185.4 5112.4 5139.2 5150.2 5157.7 5169.4 5531.5 5619.9 5654.5 5658.2 5666.5 6096.2 6175.9 6182.0 6201.1 6225.6 6274.7 6278.5 6295.3 6295.5 6297.1 5615.6 5640.9 5673.0 5701.5 5721.1 6203.9 6317.9 6322.7 6342.3 6345.9 6042.1 6045.4 6058.5 6059.9 6065.5 6061.3 6107.7 6138.7 6197.6 6199.9 6036.2 6077.0 6094.2 6105.1 6118.8 6093.7 6105.5 6118.2 6137.5 6144.8 4881.1 4902.7 4906.5 4911.0 4960.5 4312.0 4364.0 4437.3 4440.4 4447.7 5523.0 5595.3 5603.4 5719.9 5743.0 6125.6 6146.0 6152.2 6240.3 6255.2 5651.5 5696.2 5710.4 5733.5 5761.4 5255.3 5372.9 5379.4 5384.8 5394.8 6220.3 6226.0 6247.5 6270.8 6281.1 6240.8 6246.3 6249.7 6255.5 6261.7 6277.7 6288.3 6305.4 6339.3 6348.9 5940.6 5988.0 5994.3 6095.5 6128.8 6098.0 6145.5 6161.9 6204.3 6210.9 5968.9 5979.6 5981.7 5994.8 6051.5 5836.6 5870.1 5911.2 5973.6 5981.9 5748.3 5808.5 5813.7 5816.1 5821.9 5965.9 5968.9 5972.0 5973.0 5980.9 4671.9 5763.1 5819.2 5823.1 5823.6 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | [#1] ext.html Cycles:180 Average:57807.34 Median:40289.70 stddev:121101.78 (300.6%) stddev-sans-first:121364.95 09:50:41 INFO - PROCESS | 1975 | Values: 456.9 471.6 472.1 472.5 542.7 40856.6 42325.4 42423.4 42502.4 44046.8 43175.6 43582.5 43592.0 43625.3 43645.3 9507.5 9730.4 9733.7 9751.3 9755.2 9586.8 9687.0 9694.4 9702.5 9714.8 9705.0 9751.4 9769.9 9773.7 9781.5 9600.5 9627.8 9644.8 9645.6 9646.1 9418.0 9454.5 9567.4 9569.9 9579.4 40304.8 40602.8 40700.0 40743.8 40764.8 3366.4 3475.0 3546.8 3715.5 3955.1 27977.4 29291.0 30304.9 31800.5 32054.5 3187.2 3229.4 3232.6 3301.8 3318.6 467614.0 468612.0 469288.0 470169.0 470930.0 58434.4 58720.2 58798.1 58819.7 58833.7 34750.3 35155.5 35365.3 36352.5 36394.0 16284.6 16459.0 16461.3 16480.2 16502.2 12536.8 12634.4 12640.2 12640.8 12653.3 19120.6 19206.9 19211.4 19245.5 19418.3 7599.4 7650.8 7693.2 7723.9 7730.7 864.6 976.8 982.6 999.6 1061.7 25754.0 29917.6 29974.1 30524.2 30660.0 891.1 968.3 984.2 1079.4 1105.3 13877.6 15035.5 15633.5 15655.9 15675.5 187396.0 187863.0 187978.0 188537.0 646341.0 54143.5 58407.0 58800.0 58844.5 58952.4 1131.6 1233.5 1277.8 1389.2 1399.8 30303.5 30343.7 31106.8 31197.0 31200.7 41832.8 50245.0 50722.0 50746.2 50913.0 529480.0 531321.0 533760.0 534115.3 534691.0 26536.3 26620.9 27174.5 27259.0 28033.7 46974.8 47234.8 47933.3 47973.5 48132.3 38200.6 38531.0 38544.0 40021.8 40100.6 38485.6 38858.4 38873.0 40274.6 40525.6 37828.0 38400.4 38648.4 38727.8 38825.8 31949.7 34133.0 34328.7 34517.5 35087.7 25263.6 25348.5 25375.6 25642.9 26068.7 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | [#2] jquery.html Cycles:180 Average:31768.13 Median:18264.26 stddev:91319.67 (500.0%) stddev-sans-first:91545.39 09:50:41 INFO - PROCESS | 1975 | Values: 356.2 370.3 374.3 382.2 405.5 14705.8 14928.9 15741.5 20234.0 20645.3 19633.7 20161.9 20692.8 20832.6 20922.0 4943.6 5581.0 5878.7 5883.6 5884.6 4999.0 5262.6 5826.2 5875.2 5877.1 5659.8 5668.5 5819.0 5824.5 5827.3 5669.2 5793.4 5801.1 5803.2 5803.5 4835.0 4982.1 5063.6 5065.6 5081.0 25689.6 25765.1 25775.6 25809.6 26020.5 2463.5 2968.8 3084.6 3127.8 3155.8 10853.5 15735.8 15739.4 15758.6 15844.2 1748.8 1895.5 1896.8 1914.5 1931.8 73066.6 77396.0 109836.9 110727.9 112498.4 7794.9 10410.3 10447.6 10724.2 10919.8 13348.2 13358.9 13379.2 13382.1 13409.6 8037.4 8254.2 8343.0 8428.4 8464.9 8315.6 8327.4 8328.3 8495.0 8550.8 5298.5 5379.9 6526.7 6548.4 6650.7 1840.7 1860.0 1868.1 1874.8 1902.3 845.8 883.2 957.8 998.6 1031.2 21098.8 22287.4 22348.2 22417.6 22514.4 925.7 926.7 978.0 992.8 1010.8 9485.0 11065.6 11138.0 11722.2 11916.7 534359.0 553496.0 553676.0 554515.0 563903.0 65418.0 79687.2 102961.5 110327.7 115203.0 864.2 937.2 941.0 1012.9 1013.7 14403.9 18994.7 19545.9 19585.2 19752.5 36172.3 48988.5 49269.3 49309.3 50134.0 69398.0 69827.0 70334.3 70634.0 72384.0 6964.3 7157.2 7287.6 7419.5 7761.3 10243.3 10515.4 11055.5 12460.2 12932.2 9705.3 9815.2 10314.5 11115.4 11189.5 10455.9 10746.4 10836.2 10845.3 11278.7 10892.6 11133.2 11412.7 11448.5 11515.7 6520.1 7116.5 7235.8 7287.2 7472.6 9204.4 10775.8 11064.3 11109.6 11112.1 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | [#3] mootools.html Cycles:180 Average:5607.84 Median:4977.57 stddev:3132.87 (62.9%) stddev-sans-first:3126.74 09:50:41 INFO - PROCESS | 1975 | Values: 1539.4 1555.7 1784.1 1898.1 1927.2 8154.4 8596.0 8605.2 8619.7 8623.4 7796.7 8049.8 8219.0 8403.4 8583.4 2312.7 2369.0 2370.7 2374.8 2379.8 2078.5 2296.0 2360.6 2385.6 2390.7 2352.5 2365.9 2367.2 2376.2 2378.8 2321.0 2336.5 2343.2 2345.6 2359.2 2334.3 2336.0 2338.4 2343.7 2348.1 8655.0 8706.8 8715.7 8720.3 8723.3 5109.0 5176.2 5308.1 5310.8 5321.9 3426.6 3508.5 3605.5 3607.3 3627.6 987.0 1042.1 1077.0 1083.4 1096.5 11252.1 11333.6 11473.9 11474.2 11483.4 4539.8 4580.2 4695.5 4792.8 4798.3 9974.3 9974.5 9983.0 9986.5 9994.5 5315.5 5332.9 5334.1 5343.3 5345.2 4354.3 4451.8 4521.3 4822.9 4875.1 3622.3 3644.4 3879.4 3961.7 3975.6 1151.2 1275.2 1277.9 1297.7 1313.9 806.4 839.0 849.6 896.5 920.9 5404.8 5766.3 5831.9 5886.4 6018.7 876.9 891.8 909.1 911.4 947.2 3814.8 3958.7 4055.9 4059.1 4073.5 10500.7 10587.5 10707.1 10711.7 10712.6 10651.0 10665.7 10668.8 10670.4 10670.8 7986.8 8063.4 8158.5 8259.3 8269.3 4700.9 5661.6 5799.2 5834.0 5872.5 9665.2 9887.1 9907.7 9930.7 9934.9 8722.6 9298.9 10157.7 10181.1 10183.6 6098.0 6840.8 7083.0 7088.8 7531.1 6912.3 7924.9 8075.2 8298.2 8315.1 7286.7 7401.5 7422.9 7481.0 7549.9 6254.8 7244.2 7257.4 7273.8 7393.8 6608.8 6815.6 6909.3 6965.9 6966.8 4814.4 4846.1 4882.6 4915.1 4998.1 4276.4 4906.6 4915.2 4976.5 4978.7 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | [#4] prototype.html Cycles:180 Average:4388.04 Median:5048.01 stddev:1385.22 (27.4%) stddev-sans-first:1353.82 09:50:41 INFO - PROCESS | 1975 | Values: 248.9 273.2 299.9 312.3 316.6 4309.6 4409.1 5223.6 5229.7 5238.8 3919.6 4094.9 4327.8 5048.9 5173.3 3927.5 3951.9 3972.4 3980.9 4000.8 3277.3 3608.2 3955.3 3986.3 4019.6 3703.8 3921.5 3950.8 3951.3 3953.3 3383.7 3883.3 3912.5 3917.9 3921.2 3369.4 3373.9 3374.7 3387.5 3388.8 4949.2 5014.4 5026.0 5047.1 5083.5 4327.3 4422.4 4469.9 4478.9 4482.7 4476.6 4683.7 5395.7 5399.1 5433.4 3533.0 3588.6 3680.8 3702.4 3708.5 5212.6 5301.6 5496.2 5643.9 5647.6 3149.2 3319.7 3717.0 3744.0 3778.3 3192.8 3211.9 3765.9 3771.2 3785.2 3518.3 3776.4 3859.4 4384.6 4458.4 4728.7 5180.6 5248.8 5466.5 5506.7 1124.9 1198.9 1283.4 1308.7 1315.1 817.8 837.0 840.6 841.6 841.7 4966.9 5067.3 5132.5 5260.9 5299.6 5254.9 5635.0 5654.3 5682.0 5689.6 4541.3 4948.6 5113.5 5210.1 5306.1 2466.7 2481.9 2872.6 2928.2 2953.9 5475.6 5731.2 5736.7 5740.9 5778.9 5668.2 5719.7 5726.8 5770.7 5797.0 5124.5 5419.5 5489.8 5722.4 5760.5 4673.7 4915.8 5241.6 5605.7 5657.7 5122.8 5462.3 5663.4 5667.5 5669.5 5815.7 5827.3 5839.1 5845.8 5874.5 3196.7 3300.6 3564.3 3737.8 3838.4 4703.2 5090.5 5271.3 5647.5 5669.9 5518.3 5521.6 5537.8 5538.6 5565.1 4523.8 5240.2 5350.7 5486.3 5489.9 4465.6 5183.2 5333.8 5388.8 5392.6 4587.4 5369.7 5437.8 5519.9 5523.7 5413.3 5413.5 5415.3 5456.8 5463.0 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - PROCESS | 1975 | [#5] yui.html Cycles:180 Average:25253.94 Median:3643.05 stddev:41264.49 (1132.7%) stddev-sans-first:41338.56 09:50:41 INFO - PROCESS | 1975 | Values: 550.2 719.0 725.3 756.2 829.3 15115.5 15854.2 15875.6 15881.5 15885.6 14267.2 14375.2 14390.4 14394.2 14403.5 680.9 708.9 854.6 860.1 905.4 887.4 891.3 895.6 896.8 897.7 900.7 950.7 951.9 953.0 953.2 735.5 757.2 758.2 763.7 947.3 563.6 668.4 682.6 691.1 694.1 15018.9 15052.2 15063.9 15356.2 15379.5 13820.2 14037.4 14041.4 14114.6 14327.6 10489.9 12876.2 13152.2 13187.8 13615.8 4603.8 4636.9 4649.8 4838.7 4841.8 112766.0 115963.4 116377.0 117931.0 118532.4 11212.9 11249.0 11289.3 11398.0 11580.3 22124.6 22239.4 22404.0 23005.5 23052.2 7713.0 7866.3 8004.0 8011.5 8121.2 4378.7 4456.5 4463.7 4504.1 4508.2 3405.5 3517.3 3517.5 3520.4 3521.6 640.2 641.4 645.9 651.0 676.3 540.6 603.1 648.3 689.5 700.9 7977.7 9266.5 9490.4 9565.6 9639.3 583.7 631.7 649.3 682.7 683.2 3764.5 4357.4 4599.9 4620.6 4677.9 152835.0 154011.0 156814.0 158979.0 161972.2 130559.0 133849.0 133982.0 134937.0 139204.0 89247.6 112030.0 116096.0 118857.0 119972.8 8890.3 8919.5 8924.2 8968.7 9024.2 47288.8 61011.7 63075.4 68712.3 70125.6 70852.0 79161.0 96096.1 101907.5 101992.0 12052.0 12511.5 12548.1 12551.7 12804.5 12930.2 13281.0 13514.5 13549.2 13914.6 8693.4 12547.7 12562.9 12611.5 12908.7 12180.3 12226.6 12757.9 12936.5 12936.9 9758.1 10350.9 12222.3 12458.4 12629.1 10279.6 10296.2 10463.9 10576.4 10593.4 9379.3 9657.0 9682.7 10523.9 10684.2 09:50:41 INFO - PROCESS | 1975 | -------- Summary: end -------- 09:50:41 INFO - PROCESS | 1975 | 09:50:41 INFO - TEST-INFO | 1975: exit 0 09:50:41 INFO - TEST-OK | dromaeo_css | took 1119553ms 09:50:41 INFO - TEST-START | kraken 09:50:41 INFO - operating with platform_type : mac_ 09:50:41 INFO - Initialising browser for kraken test... 09:50:41 INFO - TEST-INFO | started process 1981 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpykYMcL/profile http://localhost:52096/getInfo.html) 09:50:44 INFO - PROCESS | 1981 | __metrics Screen width/height:1600/1200 09:50:44 INFO - PROCESS | 1981 | colorDepth:24 09:50:44 INFO - PROCESS | 1981 | Browser inner width/height: 1024/689 09:50:44 INFO - PROCESS | 1981 | __metrics 09:50:44 INFO - PROCESS | 1981 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:50:44 INFO - PROCESS | 1981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:50:45 INFO - TEST-INFO | 1981: exit 0 09:50:45 INFO - Browser initialized. 09:50:45 INFO - Running cycle 1/1 for kraken test... 09:50:45 INFO - TEST-INFO | started process 1982 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmpykYMcL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:57 INFO - PROCESS | 1982 | RSS: Main: 232218624 09:50:57 INFO - PROCESS | 1982 | 09:50:59 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:00 INFO - PROCESS | 1982 | RSS: Main: 290734080 09:51:00 INFO - PROCESS | 1982 | 09:51:03 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-dft) 09:51:04 INFO - PROCESS | 1982 | RSS: Main: 292159488 09:51:04 INFO - PROCESS | 1982 | 09:51:07 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-fft) 09:51:08 INFO - PROCESS | 1982 | RSS: Main: 384303104 09:51:08 INFO - PROCESS | 1982 | 09:51:10 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52096/tests/kraken/driver.html?testName=audio-oscillator) 09:51:10 INFO - PROCESS | 1982 | RSS: Main: 286191616 09:51:10 INFO - PROCESS | 1982 | 09:51:13 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:13 INFO - PROCESS | 1982 | RSS: Main: 289652736 09:51:13 INFO - PROCESS | 1982 | 09:51:16 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52096/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:17 INFO - PROCESS | 1982 | RSS: Main: 327979008 09:51:17 INFO - PROCESS | 1982 | 09:51:19 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52096/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:20 INFO - PROCESS | 1982 | RSS: Main: 330473472 09:51:20 INFO - PROCESS | 1982 | 09:51:23 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52096/tests/kraken/driver.html?testName=json-parse-financial) 09:51:23 INFO - PROCESS | 1982 | RSS: Main: 326881280 09:51:23 INFO - PROCESS | 1982 | 09:51:25 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:26 INFO - PROCESS | 1982 | RSS: Main: 303194112 09:51:26 INFO - PROCESS | 1982 | 09:51:27 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:28 INFO - PROCESS | 1982 | RSS: Main: 306606080 09:51:28 INFO - PROCESS | 1982 | 09:51:30 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:31 INFO - PROCESS | 1982 | RSS: Main: 313618432 09:51:31 INFO - PROCESS | 1982 | 09:51:34 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:51:35 INFO - PROCESS | 1982 | RSS: Main: 319754240 09:51:35 INFO - PROCESS | 1982 | 09:51:38 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:51:38 INFO - PROCESS | 1982 | RSS: Main: 319676416 09:51:38 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | Cycle 1(1): loaded http://localhost:52096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52096/tests/kraken/driver.html?testName=ai-astar) 09:51:40 INFO - PROCESS | 1982 | RSS: Main: 364015616 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | __start_tp_report 09:51:40 INFO - PROCESS | 1982 | _x_x_mozilla_page_load 09:51:40 INFO - PROCESS | 1982 | _x_x_mozilla_page_load_details 09:51:40 INFO - PROCESS | 1982 | |i|pagename|runs| 09:51:40 INFO - PROCESS | 1982 | |0;ai-astar;104;114;115;113;114;114;112;113;114;114 09:51:40 INFO - PROCESS | 1982 | |1;audio-beat-detection;152;128;140;179;100;129;143;141;146;112 09:51:40 INFO - PROCESS | 1982 | |2;audio-dft;246;252;185;186;184;185;185;182;182;182 09:51:40 INFO - PROCESS | 1982 | |3;audio-fft;94;58;59;89;62;60;59;61;83;58 09:51:40 INFO - PROCESS | 1982 | |4;audio-oscillator;94;91;122;84;66;67;91;66;66;107 09:51:40 INFO - PROCESS | 1982 | |5;imaging-gaussian-blur;87;84;87;85;92;131;87;84;86;84 09:51:40 INFO - PROCESS | 1982 | |6;imaging-darkroom;92;93;93;93;92;93;93;93;94;93 09:51:40 INFO - PROCESS | 1982 | |7;imaging-desaturate;83;84;83;78;82;81;85;83;82;83 09:51:40 INFO - PROCESS | 1982 | |8;json-parse-financial;57;56;56;53;53;55;54;54;54;54 09:51:40 INFO - PROCESS | 1982 | |9;json-stringify-tinderbox;72;68;69;76;73;71;74;71;72;72 09:51:40 INFO - PROCESS | 1982 | |10;stanford-crypto-aes;92;91;86;85;90;89;86;90;94;88 09:51:40 INFO - PROCESS | 1982 | |11;stanford-crypto-ccm;149;148;153;146;135;154;156;153;178;145 09:51:40 INFO - PROCESS | 1982 | |12;stanford-crypto-pbkdf2;174;172;172;173;170;172;173;173;172;173 09:51:40 INFO - PROCESS | 1982 | |13;stanford-crypto-sha256-iterative;69;70;69;69;68;69;69;69;67;67 09:51:40 INFO - PROCESS | 1982 | __end_tp_report 09:51:40 INFO - PROCESS | 1982 | __start_cc_report 09:51:40 INFO - PROCESS | 1982 | _x_x_mozilla_cycle_collect,1992 09:51:40 INFO - PROCESS | 1982 | __end_cc_report 09:51:40 INFO - PROCESS | 1982 | __startTimestamp1476895900698__endTimestamp 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | ------- Summary: start ------- 09:51:40 INFO - PROCESS | 1982 | Number of tests: 14 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.16 (2.8%) stddev-sans-first:0.87 09:51:40 INFO - PROCESS | 1982 | Values: 104.0 114.0 115.0 113.0 114.0 114.0 112.0 113.0 114.0 114.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:142.00 stddev:21.78 (15.3%) stddev-sans-first:22.42 09:51:40 INFO - PROCESS | 1982 | Values: 152.0 128.0 140.0 179.0 100.0 129.0 143.0 141.0 146.0 112.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#2] audio-dft Cycles:10 Average:196.90 Median:185.00 stddev:27.53 (14.9%) stddev-sans-first:22.76 09:51:40 INFO - PROCESS | 1982 | Values: 246.0 252.0 185.0 186.0 184.0 185.0 185.0 182.0 182.0 182.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#3] audio-fft Cycles:10 Average:68.30 Median:61.50 stddev:14.35 (23.3%) stddev-sans-first:11.82 09:51:40 INFO - PROCESS | 1982 | Values: 94.0 58.0 59.0 89.0 62.0 60.0 59.0 61.0 83.0 58.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:75.50 stddev:19.47 (25.8%) stddev-sans-first:20.40 09:51:40 INFO - PROCESS | 1982 | Values: 94.0 91.0 122.0 84.0 66.0 67.0 91.0 66.0 66.0 107.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:86.50 stddev:14.36 (16.6%) stddev-sans-first:15.17 09:51:40 INFO - PROCESS | 1982 | Values: 87.0 84.0 87.0 85.0 92.0 131.0 87.0 84.0 86.0 84.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#6] imaging-darkroom Cycles:10 Average:92.90 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 09:51:40 INFO - PROCESS | 1982 | Values: 92.0 93.0 93.0 93.0 92.0 93.0 93.0 93.0 94.0 93.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#7] imaging-desaturate Cycles:10 Average:82.40 Median:83.00 stddev:1.90 (2.3%) stddev-sans-first:2.00 09:51:40 INFO - PROCESS | 1982 | Values: 83.0 84.0 83.0 78.0 82.0 81.0 85.0 83.0 82.0 83.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.50 stddev:1.35 (2.5%) stddev-sans-first:1.12 09:51:40 INFO - PROCESS | 1982 | Values: 57.0 56.0 56.0 53.0 53.0 55.0 54.0 54.0 54.0 54.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.00 stddev:2.30 (3.2%) stddev-sans-first:2.44 09:51:40 INFO - PROCESS | 1982 | Values: 72.0 68.0 69.0 76.0 73.0 71.0 74.0 71.0 72.0 72.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#10] stanford-crypto-aes Cycles:10 Average:89.10 Median:90.00 stddev:2.88 (3.2%) stddev-sans-first:2.86 09:51:40 INFO - PROCESS | 1982 | Values: 92.0 91.0 86.0 85.0 90.0 89.0 86.0 90.0 94.0 88.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:153.00 stddev:11.04 (7.2%) stddev-sans-first:11.66 09:51:40 INFO - PROCESS | 1982 | Values: 149.0 148.0 153.0 146.0 135.0 154.0 156.0 153.0 178.0 145.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:173.00 stddev:1.07 (0.6%) stddev-sans-first:0.97 09:51:40 INFO - PROCESS | 1982 | Values: 174.0 172.0 172.0 173.0 170.0 172.0 173.0 173.0 172.0 173.0 09:51:40 INFO - PROCESS | 1982 | 09:51:40 INFO - PROCESS | 1982 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 09:51:40 INFO - PROCESS | 1982 | Values: 69.0 70.0 69.0 69.0 68.0 69.0 69.0 69.0 67.0 67.0 09:51:40 INFO - PROCESS | 1982 | -------- Summary: end -------- 09:51:40 INFO - PROCESS | 1982 | 09:51:41 INFO - TEST-INFO | 1982: exit 0 09:51:41 INFO - TEST-OK | kraken | took 59614ms 09:51:41 INFO - SUITE-END | took 1179s 09:51:41 INFO - Completed test suite (00:19:39) 09:51:41 INFO - javascript benchmark 09:51:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2799.5940588614653, 3290.161008942719, 3294.357600267949, 3324.6675332466743, 3355.2618423946737, 5548.361938377077, 5621.0, 5621.606487545873, 5715.657060576368, 5735.369109397968, 5602.635828671134, 5623.240862483563, 5710.942890571093, 5715.457031582004, 5735.168400581913, 4226.239276930151, 5067.74661266937, 5121.820736274231, 5153.69077855328, 5167.431582525938, 5143.27994080829, 5241.3186285782795, 5252.107141785906, 5261.921071183935, 5306.257124002643, 5071.492850714936, 5201.687898726089, 5223.138182199932, 5224.346956630421, 5311.415744268127, 5108.233764935252, 5169.793208271664, 5171.612129090333, 5172.32759741235, 5185.351831021122, 5112.386513618352, 5139.177731562932, 5150.150225212836, 5157.6647517911215, 5169.379674439054, 5531.502164805147, 5619.915701264485, 5654.547636189136, 5658.207850900877, 5666.46168613981, 6096.163860440878, 6175.907361389583, 6181.96909015452, 6201.10084037812, 6225.595336303126, 6274.749010039593, 6278.529110316745, 6295.307516173218, 6295.527835412362, 6297.118403423525, 5615.550755939515, 5640.859625968059, 5672.971635141798, 5701.543876489954, 5721.141828725725, 6203.906941395882, 6317.873642527124, 6322.71547780351, 6342.270638876496, 6345.936540634627, 6042.093685947143, 6045.425684559959, 6058.485028772516, 6059.909101363483, 6065.54508411862, 6061.302950160788, 6107.735039974563, 6138.723757430837, 6197.597156184834, 6199.876002479925, 6036.245469316335, 6077.0, 6094.207752992172, 6105.053716673922, 6118.847028824315, 6093.6554992613665, 6105.511559075263, 6118.174046503754, 6137.53759154353, 6144.771045790771, 4881.072596206709, 4902.730349830794, 4906.509349065136, 4910.975445122823, 4960.479149689303, 4312.0, 4363.956360436418, 4437.29003359461, 4440.378347031418, 4447.710898791568, 5523.0, 5595.272614560081, 5603.3836278009385, 5719.914201286984, 5743.0, 6125.571219981323, 6146.0, 6152.230971128609, 6240.31356550779, 6255.155554000243, 5651.463111004448, 5696.23100881384, 5710.428957104339, 5733.512651424592, 5761.366249712528, 5255.343082114736, 5372.8656783579945, 5379.4351593082165, 5384.78460861569, 5394.757235924393, 6220.315765265907, 6226.034964580497, 6247.5001999840815, 6270.843228919313, 6281.089242059968, 6240.781572644935, 6246.281677607133, 6249.687515624109, 6255.468285195628, 6261.749530018748, 6277.686115694289, 6288.339724328879, 6305.369463053658, 6339.3343698912795, 6348.904766428415, 5940.584159108821, 5988.041913293852, 5994.250718660168, 6095.481884039907, 6128.846778830565, 6098.038923863867, 6145.494353883327, 6161.876762464815, 6204.348543402878, 6210.906836397548, 5968.940310596839, 5979.5814292999075, 5981.742870481597, 5994.820155395345, 6051.485623721856, 5836.591438599257, 5870.119482077552, 5911.172435858897, 5973.641581505123, 5981.940180598138, 5748.252727145445, 5808.477237048686, 5813.709314534341, 5816.098504731774, 5821.912671309849, 5965.91051134242, 5968.940310596839, 5971.970140149271, 5972.970135149297, 5980.9401905980385, 4671.883202919954, 5763.077907534775, 5819.156222347651, 5823.126531020381, 5823.563232757476], "value": 5628.381953687125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.9086182763447, 471.5638034817795, 472.1006482650551, 472.4613940108277, 542.6960901894942, 40856.59143408565, 42325.36511952323, 42423.36364954528, 42502.362464563055, 44046.77976610113, 43175.56824431755, 43582.46263060543, 43592.0, 43625.34561981565, 43645.345319820226, 9507.477088760133, 9730.367526110815, 9733.659321923735, 9751.317407781458, 9755.170810481117, 9586.808263834719, 9687.031296870327, 9694.36986595869, 9702.466364349957, 9714.757131071745, 9705.0, 9751.3661611995, 9769.902300977006, 9773.706788796311, 9781.46201958892, 9600.519974001307, 9627.759306017335, 9644.75888102796, 9645.614175432975, 9646.083622055894, 9417.952910235474, 9454.4800035998, 9567.37812042215, 9569.90430095697, 9579.425234485883, 40304.79847600772, 40602.78191654255, 40699.98250043743, 40743.7962810187, 40764.79617601893, 3366.4277072897667, 3475.0096222576444, 3546.7871927684423, 3715.479832823407, 3955.0507878109047, 27977.44045119086, 29291.0, 30304.939327123666, 31800.522992154903, 32054.519182212287, 3187.199361961953, 3229.40256052631, 3232.595925509311, 3301.752368572367, 3318.634950155481, 467614.0, 468612.0, 469287.99999999657, 470169.0, 470930.0, 58434.415655842895, 58720.18318809264, 58798.11802822961, 58819.705901471076, 58833.70583147142, 34750.30499389998, 35155.47266791, 35365.29269414649, 36352.45471317932, 36394.0, 16284.592885177964, 16459.0, 16461.34154633825, 16480.17599120063, 16502.17489125539, 12536.81194782079, 12634.431450584745, 12640.178388404907, 12640.810387844005, 12653.304068276333, 19120.61758764817, 19206.934984520125, 19211.423657290303, 19245.518862028563, 19418.320358787376, 7599.354054905284, 7650.770476885702, 7693.192214817475, 7723.9227607723205, 7730.690772369042, 864.5590748718199, 976.7948730766618, 982.6020461713018, 999.5951639585979, 1061.6708820265742, 25754.0, 29917.551236731466, 29974.100776976724, 30524.236894077825, 30660.0, 891.1222445890793, 968.2979839616363, 984.2372161574837, 1079.3523885668692, 1105.2649987758211, 13877.583672489842, 15035.54893353201, 15633.530994069968, 15655.921720391325, 15675.529734107995, 187396.0, 187863.0, 187978.0, 188537.0, 646341.0, 54143.45856541463, 58407.0, 58800.0, 58844.52888677732, 58952.41047589469, 1131.6491887514896, 1233.5374234662002, 1277.8338815953866, 1389.1595584671331, 1399.8460169381563, 30303.545446818756, 30343.696563034086, 31106.84446577843, 31197.0, 31200.68799311978, 41832.79083604684, 50244.995100098524, 50722.0, 50746.2388064172, 50913.0, 529480.0, 531321.0, 533760.0, 534115.3059642893, 534691.0, 26536.336591585365, 26620.86689566617, 27174.456510870066, 27259.0, 28033.738481767963, 46974.76512617415, 47234.76382618065, 47933.28100078571, 47973.520264796905, 48132.27801583049, 38200.61799381971, 38531.0, 38544.0, 40021.79989100036, 40100.598994009684, 38485.615143848205, 38858.4171237426, 38873.0, 40274.59725402708, 40525.594744053364, 37828.0, 38400.42399363956, 38648.42027369648, 38727.80636096802, 38825.805870970464, 31949.68050319467, 34133.0, 34328.656713432545, 34517.482237766955, 35087.71929824553, 25263.62104568396, 25348.493030139663, 25375.61936570916, 25642.871785640953, 26068.73931260739], "value": 19203.88450519165, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.24653857092255, 370.342641810786, 374.30005888987597, 382.2278996427218, 405.5214846481151, 14705.779413308795, 14928.925355373221, 15741.527754167393, 20234.0, 20645.277415290468, 19633.705494417594, 20161.891095989715, 20692.793072069275, 20832.583348333024, 20922.0, 4943.629227807911, 5580.972095139518, 5878.676672782995, 5883.646981181121, 5884.558658100638, 4999.0, 5262.578993680497, 5826.21346118275, 5875.206847075654, 5877.14781356703, 5659.773609055633, 5668.489835914787, 5818.970905145468, 5824.534037277029, 5827.300723913137, 5669.23465332179, 5793.449622285876, 5801.071828507461, 5803.245578074865, 5803.506701930341, 4834.975825120852, 4982.053409852153, 5063.569596584295, 5065.569426598743, 5080.974595127001, 25689.614655780177, 25765.098221562344, 25775.613365799527, 25809.580473073973, 26020.479590408086, 2463.531928933497, 2968.821870687744, 3084.599002129731, 3127.8279694616785, 3155.826429546374, 10853.5115919783, 15735.763963540556, 15739.449119280885, 15758.606034849221, 15844.20778961059, 1748.7918878238197, 1895.5261184703825, 1896.838768704648, 1914.525815122348, 1931.777845547766, 73066.63466682633, 77396.0, 109836.90163098427, 110727.89272107257, 112498.43750781275, 7794.883076753853, 10410.323328983592, 10447.634332798316, 10724.195685323632, 10919.781604367869, 13348.199108053548, 13358.866411335957, 13379.197248165141, 13382.13016153947, 13409.597712068653, 8037.35701143907, 8254.174582541698, 8342.998840139222, 8428.410011299273, 8464.873026904601, 8315.584220788936, 8327.364609446457, 8328.292095171857, 8494.957525212334, 8550.78623034429, 5298.549623282064, 5379.946200538023, 6526.706298216592, 6548.410643042149, 6650.70071846768, 1840.6962851129413, 1859.9907000464912, 1868.0753027251326, 1874.8218919202654, 1902.286642509059, 845.8477474054606, 883.1742320929951, 957.760559860035, 998.605550807427, 1031.2368847053276, 21098.789012109683, 22287.442813929458, 22348.21781237649, 22417.551648966928, 22514.437139071655, 925.6806401791371, 926.749777560055, 977.9853302200472, 992.8163289791412, 1010.8382658774708, 9485.004074572209, 11065.557377704801, 11138.0, 11722.179447438597, 11916.702082447835, 534359.0, 553496.0, 553676.0, 554515.0, 563903.0, 65418.0, 79687.20312796914, 102961.48519257506, 110327.69016929505, 115203.0, 864.2049314630555, 937.1518775508176, 941.0448394879203, 1012.8733908261468, 1013.6756238003916, 14403.855961440251, 18994.715079273545, 19545.902270488557, 19585.216591336186, 19752.506187345432, 36172.27655446929, 48988.510114898396, 49269.260961084896, 49309.2603610939, 50134.0, 69398.0, 69826.95259571212, 70334.29665703482, 70634.0, 72384.0, 6964.338387853146, 7157.1769246537315, 7287.635618219174, 7419.517731347445, 7761.301482866569, 10243.282970192313, 10515.421651809223, 11055.502502387573, 12460.190087644274, 12932.224066556037, 9705.320627556004, 9815.2147828175, 10314.535845886803, 11115.44422778874, 11189.496472658913, 10455.895441045797, 10746.355218686904, 10836.187285953427, 10845.295055821347, 11278.718032049264, 10892.564297428014, 11133.220674552704, 11412.71468213268, 11448.484818183368, 11515.712107197387, 6520.087187793618, 7116.537425067354, 7235.782926512213, 7287.1984081752025, 7472.589007604634, 9204.355695101547, 10775.838362424727, 11064.336139831636, 11109.611163609557, 11112.111031117653], "value": 9335.681785491712, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1539.3611651164763, 1555.7277476441623, 1784.1079460269866, 1898.0794314757331, 1927.219476112174, 8154.3884208684285, 8595.95702021489, 8605.225529702326, 8619.655213791448, 8623.353248506355, 7796.727114550992, 8049.758507244777, 8219.0, 8403.41176117672, 8583.356248281372, 2312.7109111361124, 2368.95262094758, 2370.679958205646, 2374.750651181627, 2379.8453100548495, 2078.5011597216712, 2295.988520057397, 2360.563295790276, 2385.5586716457424, 2390.689210402645, 2352.529494101178, 2365.858048517086, 2367.183321753992, 2376.2039716694926, 2378.7502312257225, 2321.0483701682397, 2336.4742932840145, 2343.203310874294, 2345.636426353918, 2359.197872723282, 2334.253039027495, 2335.9649605255936, 2338.427085364097, 2343.742188359279, 2348.072511358021, 8654.956725216334, 8706.825863482694, 8715.694950676696, 8720.345974051908, 8723.345749068782, 5109.0, 5176.249443830661, 5308.097623404031, 5310.814121505768, 5321.9201711973965, 3426.58880934287, 3508.473728940654, 3605.47720580517, 3607.3146102240753, 3627.564692236922, 986.9506524673809, 1042.1350279268265, 1077.0414331245197, 1083.3716444462193, 1096.5120521367994, 11252.099832013419, 11333.603323883624, 11473.885261147365, 11474.196806223568, 11483.368414737186, 4539.773011349419, 4580.198465268565, 4695.460022097434, 4792.784324705397, 4798.256270278112, 9974.301798874008, 9974.451405172786, 9982.950085249528, 9986.500674966223, 9994.450305233282, 5315.495027972336, 5332.9466705333225, 5334.093204155303, 5343.278657381282, 5345.1714984177515, 4354.259775838115, 4451.821927122879, 4521.321801729701, 4822.903541929142, 4875.098106850173, 3622.293652737691, 3644.3986742187244, 3879.3792993120965, 3961.7028722845325, 3975.5626881043063, 1151.1826603111717, 1275.222114510148, 1277.8977681785434, 1297.6755811047237, 1313.90802643814, 806.4435539477741, 838.980638524196, 849.609179777297, 896.5158814240237, 920.9033051529627, 5404.756785944642, 5766.336871259775, 5831.88336233273, 5886.381929897385, 6018.668973206516, 876.9446968681266, 891.772597987509, 909.0909090909091, 911.3711539038175, 947.2232769129248, 3814.809259537012, 3958.722889397772, 4055.858044968412, 4059.106996460774, 4073.5315438724333, 10500.684979450476, 10587.523561439753, 10707.089897358812, 10711.678649640524, 10712.625058122929, 10651.041406273473, 10665.680029599125, 10668.786624267472, 10670.41312727792, 10670.786584268426, 7986.7603971880935, 8063.435559510778, 8158.510489370657, 8259.256666900008, 8269.255766981001, 4700.858974230779, 5661.603687741818, 5799.159121927212, 5834.0, 5872.471477567039, 9665.226781857575, 9887.060729230712, 9907.702768916944, 9930.652427165014, 9934.850977235492, 8722.563871806258, 9298.860517092384, 10157.746056348355, 10181.134603558781, 10183.643572474928, 6097.969510152599, 6840.828979275558, 7083.043789088407, 7088.822779430556, 7531.133919599316, 6912.343327383891, 7924.881126783218, 8075.192480751878, 8298.21166989135, 8315.126911674188, 7286.7085316586745, 7401.519696060917, 7422.925770742439, 7481.0, 7549.943007978777, 6254.781082662085, 7244.166920804175, 7257.419406447577, 7273.781786546412, 7393.8151546211775, 6608.8347791305605, 6815.591064536144, 6909.343612356818, 6965.895511567229, 6966.79099627012, 4814.398200224972, 4846.103470857903, 4882.633802464758, 4915.139850526215, 4998.050370429607, 4276.444062271885, 4906.6320025997475, 4915.188993816123, 4976.477469865757, 4978.655762943912], "value": 4520.685851284681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.89421995651844, 273.237666909323, 299.86655938107543, 312.28486765307434, 316.63903150408527, 4309.612134907858, 4409.0900005996045, 5223.6343455958095, 5229.686218826868, 5238.816641417541, 3919.608538968661, 4094.877153685387, 4327.783610819462, 5048.873778155548, 5173.344529750481, 3927.4894263745814, 3951.881443556698, 3972.36442169253, 3980.9402858956996, 4000.7599544027307, 3277.2953814929783, 3608.2242317901646, 3955.288048151346, 3986.3422535281643, 4019.593142400166, 3703.7962912039825, 3921.490206273195, 3950.762954222756, 3951.3480275754464, 3953.327934251184, 3383.729301655886, 3883.3010058189516, 3912.4522566840665, 3917.8628747993826, 3921.1961547882615, 3369.4103531881824, 3373.9493907591404, 3374.6794054564775, 3387.491876218562, 3388.8477917508167, 4949.232868905326, 5014.448410674823, 5026.019926114409, 5047.141985862412, 5083.466236045236, 4327.2643650579475, 4422.358757980107, 4469.888252793706, 4478.932816007762, 4482.7448314472, 4476.641868650533, 4683.718976861399, 5395.73379180745, 5399.1091469907415, 5433.375161856358, 3533.0460775590705, 3588.6411358864166, 3680.7975561344115, 3702.426123950792, 3708.4808126862263, 5212.582993360522, 5301.575873930076, 5496.167960656049, 5643.915341269884, 5647.604667673265, 3149.2441813964483, 3319.68462996015, 3716.962830371716, 3743.970408137784, 3778.263238668433, 3192.824394658316, 3211.935761284808, 3765.9246815064093, 3771.226898485859, 3785.2240290740333, 3518.3491054155065, 3776.4335349697217, 3859.363205071188, 4384.56154384559, 4458.398116254264, 4728.739919304402, 5180.585553155738, 5248.790048398021, 5466.480684334982, 5506.697131657797, 1124.8987591116838, 1198.8801119887942, 1283.3903895649678, 1308.7436061381181, 1315.1451556488169, 817.7751118442476, 837.0206857976183, 840.6133178737849, 841.5750046226739, 841.6507149532875, 4966.925496117561, 5067.341245638044, 5132.486751324912, 5260.947390526122, 5299.615173172088, 5254.868628284247, 5635.0, 5654.321481422174, 5681.971590142023, 5689.630174038674, 4541.341505481752, 4948.554630083309, 5113.463086375951, 5210.140326846028, 5306.071437498423, 2466.654668346433, 2481.9379515512255, 2872.5834753960557, 2928.238657948906, 2953.9113826585235, 5475.616706830484, 5731.168980497804, 5736.741846616829, 5740.942590574041, 5778.94221057784, 5668.214512428572, 5719.7426115824055, 5726.770929162787, 5770.720565376737, 5796.971015144897, 5124.538791508782, 5419.539339156137, 5489.780408783604, 5722.4277572242445, 5760.53915686744, 4673.7429441381055, 4915.827946021872, 5241.6068794839775, 5605.691686957257, 5657.660540367591, 5122.846314610568, 5462.34647140208, 5663.4053424391495, 5667.498112999976, 5669.489745922887, 5815.678654031513, 5827.329857066322, 5839.051279104195, 5845.843244648013, 5874.500667443144, 3196.6504619105403, 3300.636929937657, 3564.3405969895653, 3737.794421306854, 3838.3858582627763, 4703.247480403119, 5090.49095090488, 5271.262023316815, 5647.5034115960125, 5669.886602268014, 5518.310211223597, 5521.585881058856, 5537.8061767837935, 5538.6399884007415, 5565.076620982279, 4523.7964291606295, 5240.244041679613, 5350.652207606493, 5486.31421072366, 5489.937446289797, 4465.59809617136, 5183.196604526304, 5333.759980800795, 5388.838334849961, 5392.622516423813, 4587.449506059294, 5369.704666243394, 5437.755301011385, 5519.862003449946, 5523.696196709219, 5413.296271484682, 5413.512783849473, 5415.268938693226, 5456.781728730806, 5462.9726851365485], "value": 3942.8303169231467, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.2324257660564, 718.9928100718992, 725.2529894208967, 756.1870988687159, 829.2826704900264, 15115.546533603996, 15854.2072896355, 15875.60310992223, 15881.523554293375, 15885.602859928493, 14267.215303158322, 14375.209363485004, 14390.352434140463, 14394.208318542476, 14403.495877644285, 680.8910574308112, 708.9149302083757, 854.5897968974896, 860.1398601398602, 905.4024343933006, 887.4364778365752, 891.3092353426082, 895.6014573514789, 896.7847716548014, 897.6768363389175, 900.6712549919265, 950.7337945375272, 951.8714973478561, 952.9618815247381, 953.208836665566, 735.5035351138014, 757.2427572427572, 758.2190343945745, 763.6563546404141, 947.313197931501, 563.5519761789387, 668.4017804065383, 682.5836239893661, 691.0636088100651, 694.1080711286023, 15018.924905375512, 15052.172130532816, 15063.945523813338, 15356.155411452366, 15379.461718839899, 13820.170789752647, 14037.438502459889, 14041.368138433794, 14114.576562703136, 14327.570172894726, 10489.947550262275, 12876.227426354355, 13152.21086734799, 13187.802182967263, 13615.795763063563, 4603.769811509411, 4636.884077898046, 4649.790759415834, 4838.709677419366, 4841.837958889876, 112766.0, 115963.42018289938, 116377.0, 117930.99999999914, 118532.40733796362, 11212.887871121184, 11249.0, 11289.322640641587, 11398.0, 11580.305181689126, 22124.55750884973, 22239.44401389978, 22403.991820368123, 23005.539889202457, 23052.193173238855, 7712.9614351927885, 7866.252705992922, 8003.959980200062, 8011.519308841488, 8121.187881211949, 4378.737275763465, 4456.487503937024, 4463.66522510813, 4504.121696269196, 4508.18852606534, 3405.506201600754, 3517.314123745845, 3517.4547945068557, 3520.3663340598937, 3521.559805024372, 640.1517988665038, 641.4419455074116, 645.9128017717547, 651.0397164182792, 676.2763842688374, 540.5945540844367, 603.0923460192382, 648.3224283708255, 689.5450599235609, 700.94042006429, 7977.680892764341, 9266.490343031062, 9490.430574165572, 9565.569549370295, 9639.277054220962, 583.6643929740417, 631.7378288010516, 649.2695717318018, 682.7030241844814, 683.1631251716707, 3764.5482542095124, 4357.411749413852, 4599.896024954054, 4620.630349572026, 4677.924077462203, 152835.0, 154011.0, 156814.0, 158979.0, 161972.19013905092, 130559.0, 133849.0, 133982.0, 134937.0, 139204.0, 89247.55376223077, 112030.0, 116096.0, 118857.0, 119972.80027199791, 8890.33322500828, 8919.509426981578, 8924.241439477717, 8968.68609598661, 9024.232940200156, 47288.763556182, 61011.694941525006, 63075.36924630879, 68712.31287687259, 70125.64937175282, 70852.0, 79161.0, 96096.07807843664, 101907.49046254721, 101992.0, 12052.035837132833, 12511.499540018298, 12548.121631485708, 12551.748965020832, 12804.487820487077, 12930.159539629894, 13281.0, 13514.459421623025, 13549.187048777105, 13914.582562523141, 8693.39146259781, 12547.74904501923, 12562.932150767287, 12611.495540178657, 12908.741825163257, 12180.269183848997, 12226.633201003984, 12757.936210318889, 12936.482540698267, 12936.935315323362, 9758.06692783891, 10350.896491034993, 12222.266664000188, 12458.377081145725, 12629.11596188258, 10279.588816447558, 10296.17630589536, 10463.895361046292, 10576.418296993432, 10593.36439813583, 9379.296552758708, 9656.95171524138, 9682.70951871445, 10523.94738026305, 10684.198685098803], "value": 7750.308706761859, "unit": "score"}], "name": "dromaeo_css", "value": 7200.8339271663945, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 115.0, 113.0, 114.0, 114.0, 112.0, 113.0, 114.0, 114.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 140.0, 179.0, 100.0, 129.0, 143.0, 141.0, 146.0, 112.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [246.0, 252.0, 185.0, 186.0, 184.0, 185.0, 185.0, 182.0, 182.0, 182.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 58.0, 59.0, 89.0, 62.0, 60.0, 59.0, 61.0, 83.0, 58.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 91.0, 122.0, 84.0, 66.0, 67.0, 91.0, 66.0, 66.0, 107.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 92.0, 131.0, 87.0, 84.0, 86.0, 84.0], "value": 90.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 93.0, 93.0, 92.0, 93.0, 93.0, 93.0, 94.0, 93.0], "value": 92.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 78.0, 82.0, 81.0, 85.0, 83.0, 82.0, 83.0], "value": 82.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 53.0, 53.0, 55.0, 54.0, 54.0, 54.0, 54.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 69.0, 76.0, 73.0, 71.0, 74.0, 71.0, 72.0, 72.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 86.0, 85.0, 90.0, 89.0, 86.0, 90.0, 94.0, 88.0], "value": 89.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 153.0, 146.0, 135.0, 154.0, 156.0, 153.0, 178.0, 145.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 172.0, 173.0, 170.0, 172.0, 173.0, 173.0, 172.0, 173.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 67.0, 67.0], "value": 68.6, "unit": "score"}], "name": "kraken", "value": 1474.5, "alertThreshold": 2.0}]} 09:51:41 INFO - Return code: 0 09:51:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:51:42 INFO - # TBPL SUCCESS # 09:51:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:51:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:51:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:51:42 INFO - 2016-10-19 09:51:42.046 screenresolution[1986:15561] starting screenresolution argv=screenresolution get 09:51:42 INFO - 2016-10-19 09:51:42.048 screenresolution[1986:15561] Display 0: 1600x1200x32@60 09:51:42 INFO - 2016-10-19 09:51:42.054 screenresolution[1987:15564] starting screenresolution argv=screenresolution list 09:51:42 INFO - Available Modes on Display 0 09:51:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:51:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:51:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:51:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:51:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:51:42 INFO - Intel Iris: 09:51:42 INFO - Chipset Model: Intel Iris 09:51:42 INFO - Type: GPU 09:51:42 INFO - Bus: Built-In 09:51:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:51:42 INFO - Vendor: Intel (0x8086) 09:51:42 INFO - Device ID: 0x0a2e 09:51:42 INFO - Revision ID: 0x0009 09:51:42 INFO - Displays: 09:51:42 INFO - Display: 09:51:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:51:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:51:42 INFO - Display Serial Number: 1600x1200 60 09:51:42 INFO - Main Display: Yes 09:51:42 INFO - Mirror: Off 09:51:42 INFO - Online: Yes 09:51:42 INFO - Rotation: Supported 09:51:42 INFO - Return code: 0 09:51:42 INFO - Running post-action listener: _resource_record_post_action 09:51:42 INFO - [mozharness: 2016-10-19 16:51:42.289859Z] Finished run-tests step (success) 09:51:42 INFO - Running post-run listener: _resource_record_post_run 09:51:42 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 819200; Write bytes: 709140480; Read time: 9; Write time: 1985 09:51:42 INFO - TinderboxPrint: CPU usage
53.4% 09:51:42 INFO - TinderboxPrint: I/O read bytes / time
819,200 / 9 09:51:42 INFO - TinderboxPrint: I/O write bytes / time
709,140,480 / 1,985 09:51:42 INFO - TinderboxPrint: CPU idle
2,261.9 (46.6%) 09:51:42 INFO - TinderboxPrint: CPU system
970.2 (20.0%) 09:51:42 INFO - TinderboxPrint: CPU user
1,625.7 (33.5%) 09:51:42 INFO - TinderboxPrint: Swap in / out
407,392,256 / 0 09:51:42 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401441280; Write bytes: 397245440; Read time: 29498; Write time: 829 09:51:42 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 782336; Write bytes: 297518080; Read time: 9; Write time: 1110 09:51:42 INFO - Running post-run listener: _upload_blobber_files 09:51:42 INFO - Blob upload gear active. 09:51:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:51:42 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 09:51:42 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:51:42 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:51:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:43 INFO - (blobuploader) - INFO - Done attempting. 09:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:44 INFO - (blobuploader) - INFO - Done attempting. 09:51:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:51:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:51:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:51:46 INFO - (blobuploader) - INFO - Done attempting. 09:51:46 INFO - (blobuploader) - INFO - Iteration through files over. 09:51:46 INFO - Return code: 0 09:51:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:51:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:51:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ef8d83c4e3b3a1d9faf525be8196cc9a15e6f56723b775757404368386eef5d1a3b7b0c2fc9fc72a110cc6e4b064928c35d573ac6860860d8ee9fbca08492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4be082ea3f29fb4a142ac8a36c77abf2385fbe906508e3993f8a6ef0c2e681bdb20d78f7046501bfbe162d341281dab10fc77494fbf63b3ca151269c2707b73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a10d1444cd6da2a69b5f0277c0d2e68b1ec6491bc7426ea12c7630f9d180e7d244f1e462979687c4b63005b4027bf58978bf8c01ee3684c2d73136dc47084e4"} 09:51:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:51:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:51:46 INFO - Contents: 09:51:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ef8d83c4e3b3a1d9faf525be8196cc9a15e6f56723b775757404368386eef5d1a3b7b0c2fc9fc72a110cc6e4b064928c35d573ac6860860d8ee9fbca08492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4be082ea3f29fb4a142ac8a36c77abf2385fbe906508e3993f8a6ef0c2e681bdb20d78f7046501bfbe162d341281dab10fc77494fbf63b3ca151269c2707b73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a10d1444cd6da2a69b5f0277c0d2e68b1ec6491bc7426ea12c7630f9d180e7d244f1e462979687c4b63005b4027bf58978bf8c01ee3684c2d73136dc47084e4"} 09:51:46 INFO - Running post-run listener: copy_logs_to_upload_dir 09:51:46 INFO - Copying logs to upload dir... 09:51:46 INFO - mkdir: /builds/slave/test/build/upload/logs 09:51:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.229139 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-10-19 09:51:47.017528) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 09:51:47.020755) ========= 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.HODvUeb7js/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.JZOO5JPn70/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ef8d83c4e3b3a1d9faf525be8196cc9a15e6f56723b775757404368386eef5d1a3b7b0c2fc9fc72a110cc6e4b064928c35d573ac6860860d8ee9fbca08492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4be082ea3f29fb4a142ac8a36c77abf2385fbe906508e3993f8a6ef0c2e681bdb20d78f7046501bfbe162d341281dab10fc77494fbf63b3ca151269c2707b73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a10d1444cd6da2a69b5f0277c0d2e68b1ec6491bc7426ea12c7630f9d180e7d244f1e462979687c4b63005b4027bf58978bf8c01ee3684c2d73136dc47084e4"} build_url:https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011088 build_url: 'https://queue.taskcluster.net/v1/task/RGG-QkoaSJSng_v5_-uXYw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ef8d83c4e3b3a1d9faf525be8196cc9a15e6f56723b775757404368386eef5d1a3b7b0c2fc9fc72a110cc6e4b064928c35d573ac6860860d8ee9fbca08492e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4be082ea3f29fb4a142ac8a36c77abf2385fbe906508e3993f8a6ef0c2e681bdb20d78f7046501bfbe162d341281dab10fc77494fbf63b3ca151269c2707b73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a10d1444cd6da2a69b5f0277c0d2e68b1ec6491bc7426ea12c7630f9d180e7d244f1e462979687c4b63005b4027bf58978bf8c01ee3684c2d73136dc47084e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 09:51:47.053811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:51:47.054173) ========= 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.HODvUeb7js/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.JZOO5JPn70/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/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.005097 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:51:47.104168) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 09:51:47.104539) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 09:51:47.104905) ========= ========= Total master_lag: 0.18 =========