builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0064 starttime: 1494349052.58 results: success (0) revision: ec15663c6331c8227d458bce85e6ca1b37423336 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.581023) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.581485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.581767) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.606867) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.607174) ========= 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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 --2017-05-09 09:57: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% 9.38M=0.001s 2017-05-09 09:57:32 (9.38 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138426 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.768855) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.769196) ========= 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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.035177 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:32.825277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 09:57:32.825616) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec15663c6331c8227d458bce85e6ca1b37423336 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev ec15663c6331c8227d458bce85e6ca1b37423336 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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 2017-05-09 09:57:32,926 truncating revision to first 12 chars 2017-05-09 09:57:32,926 Setting DEBUG logging. 2017-05-09 09:57:32,926 attempt 1/10 2017-05-09 09:57:32,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec15663c6331?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 09:57:34,279 unpacking tar archive at: mozilla-central-ec15663c6331/testing/mozharness/ program finished with exit code 0 elapsedTime=1.626096 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-09 09:57:34.473736) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:34.474110) ========= script_repo_revision: ec15663c6331c8227d458bce85e6ca1b37423336 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:34.474539) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:34.474822) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 09:57:34.493912) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-09 09:57:34.494297) ========= /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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:57:34 INFO - MultiFileLogger online at 20170509 09:57:34 in /builds/slave/test 09:57: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:57:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:34 INFO - {'append_to_log': False, 09:57:34 INFO - 'base_work_dir': '/builds/slave/test', 09:57:34 INFO - 'blob_upload_branch': 'Firefox', 09:57:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:34 INFO - 'branch': 'Firefox', 09:57:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:34 INFO - 'config_files': ('talos/mac_config.py',), 09:57:34 INFO - 'default_actions': ('clobber', 09:57:34 INFO - 'read-buildbot-config', 09:57:34 INFO - 'download-and-extract', 09:57:34 INFO - 'populate-webroot', 09:57:34 INFO - 'create-virtualenv', 09:57:34 INFO - 'install', 09:57:34 INFO - 'run-tests'), 09:57:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:34 INFO - 'download_minidump_stackwalk': True, 09:57:34 INFO - 'download_symbols': 'ondemand', 09:57:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:34 INFO - 'gecko_profile': False, 09:57:34 INFO - 'gecko_profile_interval': 0, 09:57:34 INFO - 'installer_path': 'installer.exe', 09:57:34 INFO - 'log_level': 'info', 09:57:34 INFO - 'log_name': 'talos', 09:57:34 INFO - 'log_to_console': True, 09:57:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:57:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:57:34 INFO - 'opt_config_files': (), 09:57:34 INFO - 'pip_index': False, 09:57:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:34 INFO - 'cmd': ('bash', 09:57:34 INFO - '-c', 09:57:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:34 INFO - 'enabled': True, 09:57:34 INFO - 'halt_on_failure': False, 09:57:34 INFO - 'name': 'check_screen_resolution'},), 09:57:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:57:34 INFO - 'cmd': ('bash', 09:57:34 INFO - '-c', 09:57:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:57:34 INFO - 'enabled': True, 09:57:34 INFO - 'halt_on_failure': False, 09:57:34 INFO - 'name': 'check_screen_resolution'},), 09:57:34 INFO - 'run_cmd_checks_enabled': True, 09:57:34 INFO - 'suite': 'dromaeojs', 09:57:34 INFO - 'system_bits': '32', 09:57:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:34 INFO - 'title': 't-yosemite-r7-0064', 09:57:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:34 INFO - 'use_talos_json': True, 09:57:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:34 INFO - 'work_dir': 'build'} 09:57:34 INFO - [mozharness: 2017-05-09 16:57:34.707129Z] Running clobber step. 09:57:34 INFO - Running pre-action listener: _resource_record_pre_action 09:57:34 INFO - Running main action method: clobber 09:57:34 INFO - rmtree: /builds/slave/test/build 09:57:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:37 INFO - Running post-action listener: _resource_record_post_action 09:57:37 INFO - [mozharness: 2017-05-09 16:57:37.242649Z] Finished clobber step (success) 09:57:37 INFO - [mozharness: 2017-05-09 16:57:37.242786Z] Running read-buildbot-config step. 09:57:37 INFO - Running pre-action listener: _resource_record_pre_action 09:57:37 INFO - Running main action method: read_buildbot_config 09:57:37 INFO - Using buildbot properties: 09:57:37 INFO - { 09:57:37 INFO - "project": "", 09:57:37 INFO - "product": "firefox", 09:57:37 INFO - "who": "cbook@mozilla.com", 09:57:37 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 09:57:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:57:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:57:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:57:37 INFO - "stage_platform": "macosx64", 09:57:37 INFO - "basedir": "/builds/slave/test", 09:57:37 INFO - "buildnumber": 31, 09:57:37 INFO - "platform": "yosemite_r7", 09:57:37 INFO - "parent_task_id": "Hd0MnQ4bTomi0Yc9PGoE9w", 09:57:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:57:37 INFO - "slavebuilddir": "test", 09:57:37 INFO - "taskId": "YbCFmZvRThC_kw-2NXNbYg", 09:57:37 INFO - "branch": "mozilla-central", 09:57:37 INFO - "script_repo_revision": "production", 09:57:37 INFO - "revision": "ec15663c6331c8227d458bce85e6ca1b37423336", 09:57:37 INFO - "slavename": "t-yosemite-r7-0064", 09:57:37 INFO - "repo_path": "mozilla-central" 09:57:37 INFO - } 09:57:37 INFO - Finding installer, test and symbols from parent task. 09:57:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbCFmZvRThC_kw-2NXNbYg'}, attempt #1 09:57:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbCFmZvRThC_kw-2NXNbYg'}, attempt #1 09:57:38 INFO - Task dependencies: PethWpykT6CYBGQdDMJqRQ 09:57:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w'}, attempt #1 09:57:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:57:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/test_packages.json 09:57:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/target.crashreporter-symbols.zip 09:57:39 INFO - Running post-action listener: _resource_record_post_action 09:57:39 INFO - [mozharness: 2017-05-09 16:57:39.127285Z] Finished read-buildbot-config step (success) 09:57:39 INFO - [mozharness: 2017-05-09 16:57:39.127399Z] Running download-and-extract step. 09:57:39 INFO - Running pre-action listener: _resource_record_pre_action 09:57:39 INFO - Running main action method: download_and_extract 09:57:39 INFO - mkdir: /builds/slave/test/build/tests 09:57:39 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:57:39 INFO - trying https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:57:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:57:40 INFO - Downloaded 1325 bytes. 09:57:40 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:57:40 INFO - Using the following test package requirements: 09:57:40 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:57:40 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:57:40 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:57:40 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:57:40 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'jsshell-mac.zip'], 09:57:40 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:57:40 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:57:40 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:57:40 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:57:40 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:57:40 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:57:40 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:57:40 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:57:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:57:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:57:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:57:41 INFO - Content-Length response header: 52706469 09:57:41 INFO - Bytes received: 52706469 09:57:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:57:59 INFO - Content-Length response header: 52706469 09:57:59 INFO - Bytes received: 52706469 09:58:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:58:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:58:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:58:16 INFO - Content-Length response header: 14409362 09:58:16 INFO - Bytes received: 14409362 09:58:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:16 INFO - trying https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:58:16 INFO - Downloading https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:58:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:58:18 INFO - Downloaded 75534330 bytes. 09:58:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:58:18 INFO - mkdir: /builds/slave/test/properties 09:58:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:18 INFO - Contents: 09:58:18 INFO - build_url:https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:58:18 INFO - Running post-action listener: _resource_record_post_action 09:58:18 INFO - Running post-action listener: set_extra_try_arguments 09:58:18 INFO - [mozharness: 2017-05-09 16:58:18.870563Z] Finished download-and-extract step (success) 09:58:18 INFO - [mozharness: 2017-05-09 16:58:18.870702Z] Running populate-webroot step. 09:58:18 INFO - Running pre-action listener: _resource_record_pre_action 09:58:18 INFO - Running main action method: populate_webroot 09:58:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:18 INFO - '--tppagecycles', 09:58:18 INFO - '7'], 09:58:18 INFO - 'tests': ['tsvgm']}}, 09:58:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['damp', 'tps']}, 09:58:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'tests': ['damp', 'tps']}, 09:58:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['dromaeo_dom']}, 09:58:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:58:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:58:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['a11yr', 09:58:18 INFO - 'ts_paint', 09:58:18 INFO - 'tpaint', 09:58:18 INFO - 'sessionrestore', 09:58:18 INFO - 'sessionrestore_no_auto_restore', 09:58:18 INFO - 'tabpaint']}, 09:58:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:18 INFO - 'ts_paint', 09:58:18 INFO - 'tpaint', 09:58:18 INFO - 'sessionrestore', 09:58:18 INFO - 'sessionrestore_no_auto_restore', 09:58:18 INFO - 'tabpaint']}, 09:58:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:18 INFO - 'ts_paint', 09:58:18 INFO - 'tpaint', 09:58:18 INFO - 'sessionrestore', 09:58:18 INFO - 'sessionrestore_no_auto_restore', 09:58:18 INFO - 'tabpaint']}, 09:58:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:18 INFO - 'ts_paint', 09:58:18 INFO - 'tpaint', 09:58:18 INFO - 'sessionrestore', 09:58:18 INFO - 'sessionrestore_no_auto_restore', 09:58:18 INFO - 'tabpaint']}, 09:58:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['a11yr', 09:58:18 INFO - 'ts_paint', 09:58:18 INFO - 'tpaint', 09:58:18 INFO - 'sessionrestore', 09:58:18 INFO - 'sessionrestore_no_auto_restore', 09:58:18 INFO - 'tabpaint']}, 09:58:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['a11yr', 09:58:18 INFO - 'ts_paint', 09:58:18 INFO - 'tpaint', 09:58:18 INFO - 'sessionrestore', 09:58:18 INFO - 'sessionrestore_no_auto_restore', 09:58:18 INFO - 'tabpaint']}, 09:58:18 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:58:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:58:18 INFO - 'bloom_basic_ref']}, 09:58:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['tsvgx', 09:58:18 INFO - 'tsvgr_opacity', 09:58:18 INFO - 'tart', 09:58:18 INFO - 'tscrollx', 09:58:18 INFO - 'cart', 09:58:18 INFO - 'tsvg_static']}, 09:58:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:18 INFO - 'tsvgr_opacity', 09:58:18 INFO - 'tart', 09:58:18 INFO - 'tscrollx', 09:58:18 INFO - 'cart', 09:58:18 INFO - 'tsvg_static']}, 09:58:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'talos_options': ['--disable-e10s'], 09:58:18 INFO - 'tests': ['tp5o']}, 09:58:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:58:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'talos_options': ['--disable-e10s', 09:58:18 INFO - '--xperf_path', 09:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:18 INFO - 'tests': ['tp5n']}, 09:58:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:58:18 INFO - 'talos_options': ['--xperf_path', 09:58:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:18 INFO - 'tests': ['tp5n']}}, 09:58:18 INFO - 'talos.zip': {'path': '', 09:58:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:18 INFO - Running post-action listener: _resource_record_post_action 09:58:18 INFO - [mozharness: 2017-05-09 16:58:18.891213Z] Finished populate-webroot step (success) 09:58:18 INFO - [mozharness: 2017-05-09 16:58:18.891323Z] Running create-virtualenv step. 09:58:18 INFO - Running pre-action listener: _resource_record_pre_action 09:58:18 INFO - Running main action method: create_virtualenv 09:58:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:18 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:58:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:19 INFO - Using real prefix '/tools/python27' 09:58:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:22 INFO - Installing pip.................done. 09:58:22 INFO - Return code: 0 09:58:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:58:22 INFO - Reading from file tmpfile_stdout 09:58:22 INFO - Output received: 09:58:22 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:58:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:22 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:58:22 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:58:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:22 INFO - 'HOME': '/Users/cltbld', 09:58:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:22 INFO - 'LOGNAME': 'cltbld', 09:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:22 INFO - 'MOZ_NO_REMOTE': '1', 09:58:22 INFO - 'NO_EM_RESTART': '1', 09:58:22 INFO - 'PAGER': '/bin/cat', 09:58:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:22 INFO - 'PWD': '/builds/slave/test', 09:58:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:22 INFO - 'SHELL': '/bin/bash', 09:58:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:22 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:22 INFO - 'USER': 'cltbld', 09:58:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:22 INFO - 'XPC_FLAGS': '0x0', 09:58:22 INFO - 'XPC_SERVICE_NAME': '0', 09:58:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:23 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:58:23 INFO - Cleaning up... 09:58:23 INFO - Return code: 0 09:58:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58:23 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:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:23 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:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:23 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:23 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:58:23 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:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:23 INFO - 'HOME': '/Users/cltbld', 09:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:23 INFO - 'LOGNAME': 'cltbld', 09:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:23 INFO - 'MOZ_NO_REMOTE': '1', 09:58:23 INFO - 'NO_EM_RESTART': '1', 09:58:23 INFO - 'PAGER': '/bin/cat', 09:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:23 INFO - 'PWD': '/builds/slave/test', 09:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:23 INFO - 'SHELL': '/bin/bash', 09:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:23 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:23 INFO - 'USER': 'cltbld', 09:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:23 INFO - 'XPC_FLAGS': '0x0', 09:58:23 INFO - 'XPC_SERVICE_NAME': '0', 09:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:23 INFO - Downloading/unpacking psutil>=3.1.1 09:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:25 INFO - Installing collected packages: psutil 09:58:25 INFO - Running setup.py install for psutil 09:58:25 INFO - building 'psutil._psutil_osx' extension 09:58:25 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:58:26 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:58:26 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:58:26 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:58:26 INFO - building 'psutil._psutil_posix' extension 09:58:26 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:58:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:58:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:58:26 INFO - ^ 09:58:26 INFO - 1 warning generated. 09:58:26 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:58:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:26 INFO - Successfully installed psutil 09:58:26 INFO - Cleaning up... 09:58:26 INFO - Return code: 0 09:58:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:26 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:26 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:58:26 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:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:26 INFO - 'HOME': '/Users/cltbld', 09:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:26 INFO - 'LOGNAME': 'cltbld', 09:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:26 INFO - 'MOZ_NO_REMOTE': '1', 09:58:26 INFO - 'NO_EM_RESTART': '1', 09:58:26 INFO - 'PAGER': '/bin/cat', 09:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:26 INFO - 'PWD': '/builds/slave/test', 09:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:26 INFO - 'SHELL': '/bin/bash', 09:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:26 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:26 INFO - 'USER': 'cltbld', 09:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:26 INFO - 'XPC_FLAGS': '0x0', 09:58:26 INFO - 'XPC_SERVICE_NAME': '0', 09:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58:27 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:58:27 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:58:27 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:58:27 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:58:27 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:58:27 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:58:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:28 INFO - Installing collected packages: mozsystemmonitor 09:58:28 INFO - Running setup.py install for mozsystemmonitor 09:58:28 INFO - Successfully installed mozsystemmonitor 09:58:28 INFO - Cleaning up... 09:58:28 INFO - Return code: 0 09:58:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58:28 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:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:29 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:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:29 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:29 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:58:29 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:58:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:29 INFO - 'HOME': '/Users/cltbld', 09:58:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:29 INFO - 'LOGNAME': 'cltbld', 09:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:29 INFO - 'MOZ_NO_REMOTE': '1', 09:58:29 INFO - 'NO_EM_RESTART': '1', 09:58:29 INFO - 'PAGER': '/bin/cat', 09:58:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:29 INFO - 'PWD': '/builds/slave/test', 09:58:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:29 INFO - 'SHELL': '/bin/bash', 09:58:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:29 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:29 INFO - 'USER': 'cltbld', 09:58:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:29 INFO - 'XPC_FLAGS': '0x0', 09:58:29 INFO - 'XPC_SERVICE_NAME': '0', 09:58:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:29 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:58:29 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:58:29 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:58:29 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:58:29 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:58:29 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:58:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:31 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:58:31 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:58:31 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:58:31 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:58:31 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:58:31 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:58:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:31 INFO - warning: no files found matching '*.txt' 09:58:31 INFO - no previously-included directories found matching 'build' 09:58:31 INFO - no previously-included directories found matching 'dist' 09:58:31 INFO - no previously-included directories found matching '.git*' 09:58:31 INFO - Installing collected packages: jsonschema, functools32 09:58:32 INFO - Running setup.py install for functools32 09:58:32 INFO - warning: no files found matching '*.txt' 09:58:32 INFO - no previously-included directories found matching 'build' 09:58:32 INFO - no previously-included directories found matching 'dist' 09:58:32 INFO - no previously-included directories found matching '.git*' 09:58:32 INFO - Successfully installed jsonschema functools32 09:58:32 INFO - Cleaning up... 09:58:32 INFO - Return code: 0 09:58:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58:32 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:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 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:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:32 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:58:32 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:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:32 INFO - 'HOME': '/Users/cltbld', 09:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PAGER': '/bin/cat', 09:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:32 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - 'XPC_FLAGS': '0x0', 09:58:32 INFO - 'XPC_SERVICE_NAME': '0', 09:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:32 INFO - Cleaning up... 09:58:32 INFO - Return code: 0 09:58:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58:32 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:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 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:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:32 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:58:32 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:58:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:32 INFO - 'HOME': '/Users/cltbld', 09:58:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PAGER': '/bin/cat', 09:58:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:32 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - 'XPC_FLAGS': '0x0', 09:58:32 INFO - 'XPC_SERVICE_NAME': '0', 09:58:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:32 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:58:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 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:58:34 INFO - Downloading docopt-0.6.1.tar.gz 09:58:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:35 INFO - Running setup.py install for blobuploader 09:58:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:35 INFO - Running setup.py install for requests 09:58:35 INFO - Running setup.py install for docopt 09:58:35 INFO - Successfully installed blobuploader requests docopt 09:58:35 INFO - Cleaning up... 09:58:35 INFO - Return code: 0 09:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58: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:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:35 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:35 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:58:35 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:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:35 INFO - 'HOME': '/Users/cltbld', 09:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:35 INFO - 'LOGNAME': 'cltbld', 09:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:35 INFO - 'MOZ_NO_REMOTE': '1', 09:58:35 INFO - 'NO_EM_RESTART': '1', 09:58:35 INFO - 'PAGER': '/bin/cat', 09:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:35 INFO - 'PWD': '/builds/slave/test', 09:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:35 INFO - 'SHELL': '/bin/bash', 09:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:35 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:35 INFO - 'USER': 'cltbld', 09:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:35 INFO - 'XPC_FLAGS': '0x0', 09:58:35 INFO - 'XPC_SERVICE_NAME': '0', 09:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-A40Et2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-6SaJGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Mjf53s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-_Dm0dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-i1C2XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-j8l2ol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-huRY2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:36 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Zvg28u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Boby0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-DY6wH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-u4Qct_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-mFytq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-RFOPSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Sfy8zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-FMV0gL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-Y0CRC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:37 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-tGTq77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:37 INFO - Running setup.py install for manifestparser 09:58:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:38 INFO - Running setup.py install for mozcrash 09:58:38 INFO - Running setup.py install for mozdebug 09:58:38 INFO - Running setup.py install for mozdevice 09:58:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:38 INFO - Running setup.py install for mozfile 09:58:38 INFO - Running setup.py install for mozhttpd 09:58:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:38 INFO - Running setup.py install for mozinfo 09:58:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:38 INFO - Running setup.py install for mozInstall 09:58:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Running setup.py install for mozleak 09:58:39 INFO - Running setup.py install for mozlog 09:58:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Running setup.py install for moznetwork 09:58:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Running setup.py install for mozprocess 09:58:39 INFO - Running setup.py install for mozprofile 09:58:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:39 INFO - Running setup.py install for mozrunner 09:58:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:40 INFO - Running setup.py install for mozscreenshot 09:58:40 INFO - Running setup.py install for moztest 09:58:40 INFO - Running setup.py install for mozversion 09:58:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:40 INFO - Cleaning up... 09:58:40 INFO - Return code: 0 09:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:40 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:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:40 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:40 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:58:40 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:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:40 INFO - 'HOME': '/Users/cltbld', 09:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:40 INFO - 'LOGNAME': 'cltbld', 09:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:40 INFO - 'MOZ_NO_REMOTE': '1', 09:58:40 INFO - 'NO_EM_RESTART': '1', 09:58:40 INFO - 'PAGER': '/bin/cat', 09:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:40 INFO - 'PWD': '/builds/slave/test', 09:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:40 INFO - 'SHELL': '/bin/bash', 09:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:40 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:40 INFO - 'USER': 'cltbld', 09:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:40 INFO - 'XPC_FLAGS': '0x0', 09:58:40 INFO - 'XPC_SERVICE_NAME': '0', 09:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:40 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-4riv1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:40 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:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:40 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-GdyrdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:40 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-hV7Evn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ja5kDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ApH53c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-0mVM9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-yDovab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-qL2r8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-WoFv35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-P52_CV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-WvyNw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:41 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:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:41 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-ZzO2ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:42 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-brXEPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:42 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:42 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-597kp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:42 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-VgXwh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:42 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:42 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-dBOQdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:58:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:42 INFO - Running setup.py (path:/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/pip-d3HqRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:42 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:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:58:42 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:58:42 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:42 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:58:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:42 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:58:43 INFO - Downloading blessings-1.6.tar.gz 09:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:44 INFO - Installing collected packages: blessings 09:58:44 INFO - Running setup.py install for blessings 09:58:44 INFO - Successfully installed blessings 09:58:44 INFO - Cleaning up... 09:58:44 INFO - Return code: 0 09:58:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:44 INFO - Reading from file tmpfile_stdout 09:58:44 INFO - Current package versions: 09:58:44 INFO - blessings == 1.6 09:58:44 INFO - blobuploader == 1.2.4 09:58:44 INFO - docopt == 0.6.1 09:58:44 INFO - functools32 == 3.2.3-2 09:58:44 INFO - jsonschema == 2.5.1 09:58:44 INFO - manifestparser == 1.1 09:58:44 INFO - mozInstall == 1.12 09:58:44 INFO - mozcrash == 1.0 09:58:44 INFO - mozdebug == 0.1 09:58:44 INFO - mozdevice == 0.50 09:58:44 INFO - mozfile == 1.2 09:58:44 INFO - mozhttpd == 0.7 09:58:44 INFO - mozinfo == 0.9 09:58:44 INFO - mozleak == 0.1 09:58:44 INFO - mozlog == 3.4 09:58:44 INFO - moznetwork == 0.27 09:58:44 INFO - mozprocess == 0.25 09:58:44 INFO - mozprofile == 0.28 09:58:44 INFO - mozrunner == 6.13 09:58:44 INFO - mozscreenshot == 0.1 09:58:44 INFO - mozsystemmonitor == 0.3 09:58:44 INFO - moztest == 0.8 09:58:44 INFO - mozversion == 1.4 09:58:44 INFO - psutil == 3.1.1 09:58:44 INFO - requests == 1.2.3 09:58:44 INFO - wsgiref == 0.1.2 09:58:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:44 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:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 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:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:44 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:58:44 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:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:44 INFO - 'HOME': '/Users/cltbld', 09:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:44 INFO - 'LOGNAME': 'cltbld', 09:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:44 INFO - 'MOZ_NO_REMOTE': '1', 09:58:44 INFO - 'NO_EM_RESTART': '1', 09:58:44 INFO - 'PAGER': '/bin/cat', 09:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:44 INFO - 'PWD': '/builds/slave/test', 09:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:44 INFO - 'SHELL': '/bin/bash', 09:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:44 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:44 INFO - 'USER': 'cltbld', 09:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:44 INFO - 'XPC_FLAGS': '0x0', 09:58:44 INFO - 'XPC_SERVICE_NAME': '0', 09:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 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:58:44 INFO - Cleaning up... 09:58:44 INFO - Return code: 0 09:58:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:44 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:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 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:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:44 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 0x10e85ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e85d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb50159cd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, '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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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:58:44 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:58:44 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:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:58:44 INFO - 'HOME': '/Users/cltbld', 09:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:58:44 INFO - 'LOGNAME': 'cltbld', 09:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:44 INFO - 'MOZ_NO_REMOTE': '1', 09:58:44 INFO - 'NO_EM_RESTART': '1', 09:58:44 INFO - 'PAGER': '/bin/cat', 09:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:44 INFO - 'PWD': '/builds/slave/test', 09:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:58:44 INFO - 'SHELL': '/bin/bash', 09:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:58:44 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:58:44 INFO - 'USER': 'cltbld', 09:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:44 INFO - 'XPC_FLAGS': '0x0', 09:58:44 INFO - 'XPC_SERVICE_NAME': '0', 09:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:45 INFO - Cleaning up... 09:58:45 INFO - Return code: 0 09:58:45 INFO - Running post-action listener: _resource_record_post_action 09:58:45 INFO - Running post-action listener: _start_resource_monitoring 09:58:45 INFO - Starting resource monitoring. 09:58:45 INFO - [mozharness: 2017-05-09 16:58:45.170776Z] Finished create-virtualenv step (success) 09:58:45 INFO - [mozharness: 2017-05-09 16:58:45.171677Z] Running install step. 09:58:45 INFO - Running pre-action listener: _resource_record_pre_action 09:58:45 INFO - Running main action method: install 09:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:45 INFO - Reading from file tmpfile_stdout 09:58:45 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:45 INFO - Reading from file tmpfile_stdout 09:58:45 INFO - Output received: 09:58:45 INFO - Usage: mozinstall [options] installer 09:58:45 INFO - Options: 09:58:45 INFO - -h, --help show this help message and exit 09:58:45 INFO - -d DEST, --destination=DEST 09:58:45 INFO - Directory to install application into. [default: 09:58:45 INFO - "/builds/slave/test"] 09:58:45 INFO - --app=APP Application being installed. [default: firefox] 09:58:45 INFO - mkdir: /builds/slave/test/build/application 09:58:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:59:06 INFO - Reading from file tmpfile_stdout 09:59:06 INFO - Output received: 09:59:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:59:06 INFO - Running post-action listener: _resource_record_post_action 09:59:06 INFO - [mozharness: 2017-05-09 16:59:06.289935Z] Finished install step (success) 09:59:06 INFO - [mozharness: 2017-05-09 16:59:06.290111Z] Running run-tests step. 09:59:06 INFO - Running pre-action listener: _resource_record_pre_action 09:59:06 INFO - Running main action method: run_tests 09:59:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:59:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:59:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:59:06 INFO - 2017-05-09 09:59:06.304 screenresolution[1622:7412] starting screenresolution argv=screenresolution get 09:59:06 INFO - 2017-05-09 09:59:06.307 screenresolution[1622:7412] Display 0: 1600x1200x32@60 09:59:06 INFO - 2017-05-09 09:59:06.313 screenresolution[1623:7415] starting screenresolution argv=screenresolution list 09:59:06 INFO - Available Modes on Display 0 09:59:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:59:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:59:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:59:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:59:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:59:06 INFO - Intel Iris: 09:59:06 INFO - Chipset Model: Intel Iris 09:59:06 INFO - Type: GPU 09:59:06 INFO - Bus: Built-In 09:59:06 INFO - VRAM (Dynamic, Max): 1536 MB 09:59:06 INFO - Vendor: Intel (0x8086) 09:59:06 INFO - Device ID: 0x0a2e 09:59:06 INFO - Revision ID: 0x0009 09:59:06 INFO - Displays: 09:59:06 INFO - Display: 09:59:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:59:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:59:06 INFO - Display Serial Number: 1600x1200 60 09:59:06 INFO - Main Display: Yes 09:59:06 INFO - Mirror: Off 09:59:06 INFO - Online: Yes 09:59:06 INFO - Rotation: Supported 09:59:06 INFO - Return code: 0 09:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:59:06 INFO - Python 2.7.3 09:59:06 INFO - Return code: 0 09:59:06 INFO - grabbing minidump binary from tooltool 09:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:59:06 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 0x10e56bd30>, '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 0x10e51edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e55fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:59:06 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:59:06 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:59:06 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:59:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:59:06 INFO - Return code: 0 09:59:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:59:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:59:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:59:06 INFO - ENV: RUST_BACKTRACE is now 1 09:59:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:59:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:59:06 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/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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:59:06 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/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0064 --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:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.QWeXM8DcVL/Render', 09:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:59:06 INFO - 'HOME': '/Users/cltbld', 09:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:59:06 INFO - 'LOGNAME': 'cltbld', 09:59:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:59:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:59:06 INFO - 'MOZ_NO_REMOTE': '1', 09:59:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:59:06 INFO - 'NO_EM_RESTART': '1', 09:59:06 INFO - 'PAGER': '/bin/cat', 09:59:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:59:06 INFO - 'PWD': '/builds/slave/test', 09:59:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:59:06 INFO - 'RUST_BACKTRACE': '1', 09:59:06 INFO - 'SHELL': '/bin/bash', 09:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tv9PSwBOzZ/Listeners', 09:59:06 INFO - 'TMPDIR': '/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/', 09:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:59:06 INFO - 'USER': 'cltbld', 09:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:59:06 INFO - 'XPC_FLAGS': '0x0', 09:59:06 INFO - 'XPC_SERVICE_NAME': '0', 09:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:59:06 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/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0064', '--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:59:06 INFO - mozversion application_buildid: 20170509080151 09:59:06 INFO - mozversion application_changeset: ec15663c6331c8227d458bce85e6ca1b37423336 09:59:06 INFO - mozversion application_display_name: Nightly 09:59:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:59:06 INFO - mozversion application_name: Firefox 09:59:06 INFO - mozversion application_remotingname: firefox 09:59:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:59:06 INFO - mozversion application_vendor: Mozilla 09:59:06 INFO - mozversion application_version: 55.0a1 09:59:06 INFO - mozversion platform_buildid: 20170509080151 09:59:06 INFO - mozversion platform_changeset: ec15663c6331c8227d458bce85e6ca1b37423336 09:59:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:59:06 INFO - mozversion platform_version: 55.0a1 09:59:06 INFO - using testdate: 1494349146 09:59:06 INFO - actual date: 1494349146 09:59:06 INFO - starting webserver on 'localhost:49243' 09:59:06 INFO - SUITE-START | Running 2 tests 09:59:06 INFO - TEST-START | dromaeo_css 09:59:06 INFO - operating with platform_type : mac_ 09:59:06 INFO - Initialising browser for dromaeo_css test... 09:59:06 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpvt53mu/profile http://localhost:49243/getInfo.html) 09:59:09 INFO - PID 1633 | __metrics Screen width/height:1600/1200 09:59:09 INFO - PID 1633 | colorDepth:24 09:59:09 INFO - PID 1633 | Browser inner width/height: 1024/691 09:59:09 INFO - PID 1633 | __metrics 09:59:09 INFO - PID 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:59:09 INFO - PID 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:10 INFO - TEST-INFO | 1633: exit 0 09:59:10 INFO - Browser initialized. 09:59:10 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:10 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmpvt53mu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:21 INFO - PID 1635 | RSS: Main: 233082880 09:59:21 INFO - PID 1635 | 10:02:26 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 10:02:28 INFO - PID 1635 | RSS: Main: 403771392 10:02:28 INFO - PID 1635 | 10:05:31 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 10:05:31 INFO - PID 1635 | RSS: Main: 370401280 10:05:31 INFO - PID 1635 | 10:08:33 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 10:08:34 INFO - PID 1635 | RSS: Main: 334065664 10:08:34 INFO - PID 1635 | 10:11:36 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 10:11:37 INFO - PID 1635 | RSS: Main: 357605376 10:11:37 INFO - PID 1635 | 10:14:41 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:14:41 INFO - PID 1635 | RSS: Main: 327970816 10:14:41 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:17:44 INFO - PID 1635 | RSS: Main: 368566272 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | __start_tp_report 10:17:44 INFO - PID 1635 | _x_x_mozilla_page_load 10:17:44 INFO - PID 1635 | _x_x_mozilla_page_load_details 10:17:44 INFO - PID 1635 | |i|pagename|runs| 10:17:44 INFO - PID 1635 | |0;dojo.html;3427.954473885464;3593.6047034826165;3601.083122670637;3617.986963650177;3618.149734812317;4974.7263900485505;6113.144159817629;6158.59969102008;6229.501639868811;6277.968610156943;6204.00735882259;6223.408776166269;6281.560290779647;6284.402981716729;6309.589876658014;4947.77735001924;5229.555487783543;5359.624826262163;5427.674339539641;5449.891002179954;5459.235707001023;5464.453554644543;5509.228707980886;5517.503424691777;5581.581381396391;5341.919871201916;5432.456754324576;5436.130219164954;5454.263674403945;5530.972345138289;5407.242985981966;5417.187421886709;5454.236406903036;5489.286392768954;5508.669479831223;5414.458554144593;5416.864578385533;5425.348958125051;5433;5444.754986025639;6117.256581874144;6178.691065446755;6198.876022479525;6233.391390893257;6269;6037;6304.211973503312;6598.769043083469;6694.096296999892;6707.49693772969;6643.236027856762;6716.798496045127;6723.93276067238;6729.5625784323865;6741.123653925008;6188.752449901998;6190.380961903774;6321.273053598849;6342.682865856688;6351.523635727339;6714.194296684332;6839.658017099126;6923.965380173167;6955.095837541087;6963.303669633097;6393.584417012879;6466.418022378009;6469.514786390945;6496.187976502937;6584.440322572635;6667.299933507009;6674.966625166843;6707.5975441473665;6721.1598550181225;6722.697478613474;6598.934010659832;6600.075989361493;6605.5376123670885;6606.306337834458;6617.239017512951;6432;6518.44593209573;6602.570832895846;6665.1335326408225;6667.699953502104;5301.284326615858;5316.840494785162;5338.599605029638;5351.812686555952;5361.8123365682795;3899.6880249579967;4214.009707718745;4450.554944505524;4684.95315046852;4714.57568818808;6145.801568694062;6287.528435367366;6307.590006649553;6350.618962862243;6352.587081839665;6733.8989915151315;6762.492813039042;6768.120144381297;6769.8646027079185;6782.728690852311;6351.745930162741;6368.203974503187;6368.5860419072615;6372.936270637234;6398.8720225595225;5197.506236907488;5485.396606373296;5804.158397032406;5842.737076831553;5874.471297583238;6762.256151823295;6894.13823272091;6932.341427564374;6937.098177236927;6963.582185068912;6747.865042699217;6749.5612785168805;6759.86480270382;6764.5603035802515;6769.120014398097;6864.176298844171;6874.553154044971;6910.792676219721;6911.343422374866;6950.965245173742;6451.6774161290805;6556.63938483388;6593.307702691341;6629.204495460575;6634.303398143125;5994.681170142561;6699.598024118569;6729.990501424825;6736.191657001191;6754.189497260164;6060.575759696955;6376.585521941059;6441.742330306923;6445.484361251182;6499.1876015498065;6536.0522724205675;6539.509536784665;6546.869062618816;6551;6555.541112122296;6303.086052522451;6427.068075129174;6441.323661015714;6445.16212892321;6447.774327898501;6428.003659432796;6432.2281326241155;6476.319986401549;6533.869322613426;6543.803685889431;6376.171097757262;6391.392817682313;6398.584092034003;6406.295307516077;6416.647084410402 10:17:44 INFO - PID 1635 | |1;ext.html;755.4485225785177;799.3605115907272;805.5327909812311;1131.0103659298113;1152.0898490192749;26147.607785883203;36852.63147368526;37073.62926370736;37192;37210.25579488412;39105.60894391055;39354.80322598383;39443.40834887472;39453.802730986376;39483.81548553541;5181.766820493068;5941.673207973559;8132.430729848898;8286.337093032573;8294.170582941719;5889.676067816268;5948.791792287271;5959.553033522481;5963.194968679238;8222.301104406102;8382.203690649378;8427.115152908947;8430.283425908805;8439.987201535825;8512.1487851215;8332.375071869603;8392.538410387426;8397.958010209972;8398.328133749286;8405.495670259805;8259.83480330396;8308.29379502743;8312.625931833081;8328.458650187718;8338.874916876252;37027.4445883312;37153.25693486115;37195.25609487822;37237.81381093077;37262.528496580315;3603.6396360364015;3637.727170462226;3637.763545369569;3638.0177352115047;3644.0707619556842;30652.38695226105;30690.693093069007;30696;30712.69287307143;30761.8461907689;3059.8011129276524;3116.376724655078;3129.6557378688326;3141.7329526990234;3149.9685003149903;297035;297149;297237;297752;298966;48989;49016;49105.0178996418;49213;49280.75359623179;51854.74072629613;51951.740241298554;51983.74008129935;51986.22020669693;52003;13924.37340319688;14002.949778766633;14033.368498417596;14042.297885105703;14095.295235238196;11384.260023098472;11394;11406.14453915943;11409.144314176305;11410.600628977945;10558.472076396149;10608.151347892304;10637;12160.391980400944;12490.93827024713;4892.801263690348;5138.691678499302;5456.48163424474;5484.122540393518;5494.917576236359;909.3589019741066;1018.9453915197735;1030.9845352319721;1061.8991195836384;1080.5839751695653;24111.276661700176;24287;24293.51412971766;24335.513289734106;24339;1090.6455401994383;1093.6828319787173;1107.534835369147;1108.855848739675;1191.4042978510745;11922.344271065002;12428.067894907917;12435.316057616918;12444.751104978031;12456.626301210978;317017;317406;318066.81933180836;318613;319525;52369.738151309;52392.73803630957;52471.212931806054;52473.7376313116;52535.94928101417;1528.5108765195253;1579.1314776872673;1599.5841081318708;1610.4363472784432;1611.129989805492;23850.880745596856;23956.40108997289;23986.40033999164;24000.87999559991;24035.519289614458;37914.62085379111;37920;37950.67172648944;37959;37965.24069518539;281729.1827081703;281991;282434;282579;282788;32805.507917381736;33920.830395847865;33929.982100537025;34089.65910340964;34175.974720758415;37627.2474550502;37631;37680.81159594184;43763;44509.88725281894;27711.8915243388;30652.540211896394;30730.924417645274;30769.846150769103;31064.22339441532;29764.55353169661;30284.54573181448;30629.54055689211;31017.37965240728;31018.224544385666;36635.63364366322;36639.816800915825;36805.44791828071;37383.813080935506;37518.812405937795;25478.745212547637;29124.762772904454;29906.85046574753;31282.374352513278;31468.685313147493;22569.774302257425;24033.91847366838;24350.51298974046;24532.264032079067;24589.754102458748 10:17:44 INFO - PID 1635 | |2;jquery.html;439.14147840970907;442.8671398580427;443.29958665308806;448.27379644975133;461.6422272738627;19195.904020479895;21206.681899771516;21849.907504624745;21931.67102493464;21989;22068.8896555517;22489.987950542225;22665.433364165903;22821;23242.83785810707;6016.75932962681;6121.571489995702;6229.563930524865;6238.4697300729495;6238.719257633395;5879.7648094076185;6200.038993955944;6215.50275977923;6216.968915155418;6220.098085777559;5873.794417195399;6088.4215999479975;6164.383561643845;6166.81499555014;6180.072989051656;6064.4541991220785;6148.477379422754;6148.754049838046;6149.6617686027475;6171.59884607499;5240.947590524084;5459.672419654833;5469.206964990094;5529.4470552944385;5532.170174473821;27056.458870822473;27113;27321;27637.894484220607;27670.446591068267;2188.1794327127327;2248.7751224877543;2249.8312626553075;2252.110416385535;2254.120892851789;14512.854871451256;17638;17657.55856103595;18090.90954545232;18301.908490457594;2115.4076858479652;2132.5734853029303;2196.736391632998;2199.549092436047;2201.306588424657;110518;131745.6825431743;132255;132387;133564.3321783385;10523.684289471328;11845.348505832262;12396.938015309866;12485.687857803447;12592.773998790399;16551.08969006692;16596;16623.91688041552;16624.916875415547;16652.666946661;7143.535670181422;8907.51008694528;8946.68686595966;8973.730788076238;9076.047015063323;8328.541930193776;8384.53885036329;8534.317254619615;8555.529445880537;8579.528125953007;6180.505559555315;7686.538807671446;7720.575368354682;7731.381489480828;7733.651985660659;1752.7633769440963;2079.906404211814;2082.802133797287;2088.3630492699567;2096.6330892093824;995;1004.2769206171545;1007.7883644434751;1040.1626690514208;1054.857594224785;20350.880701561557;25267.494650106895;26499.145044978144;26790.866045669645;26821.329466763487;871.8735783311384;1031.0771859185986;1031.489412740698;1039.5322105052605;1050.8003479338902;13004.479820807252;13865.237411942238;13890.930545347208;14116.435342586181;14203.502877399242;551413;552009;559922;565499;567693;122648.38675806564;123250.27128537161;123364;125609;126994.36502817427;1165.4988355007429;1210.2375503432781;1243.9689007774878;1255.8744125587368;1257.8553466351304;22554.661680074485;23091;23303;23757.881210593838;23799.524009519366;56882.7155864218;57762.42237577739;58239.4176058234;58264.70867645634;60542.697286513285;76804;77795.22204778106;79501;79879;81285.59357203412;8452.239298463168;8499.617517211616;8707.47755134694;9011.819763604823;9235.030321816113;13751.449942002208;13979.510717124851;13985.370658320197;14399.208043557286;14400.567982960529;11729.706757331134;11890.881091188978;12004.519819207135;12045.578404755792;12148.939255303667;11030.117590592572;11085.556577736801;11223.887761122285;11240.887591123985;11379.260348077349;11795.823062654239;12101.369589123404;12171.208871423683;12201.938990305347;12278;8570.914290857012;8840.778980525538;8895.021547629885;8906.465612063297;9009.684661036832;11560;11681.415929203336;11842;11941.761164776482;12013.879861201625 10:17:44 INFO - PID 1635 | |3;mootools.html;1157.5774842182607;1373.711520580678;1410.5838777560618;1423.096333828019;1439.1940513312545;9816.214702823774;10223.131033862112;10237.436940968244;10249.590016399345;10253.743656408584;9274.768130796734;10046.497675116234;11649.592264270752;11655.708607284821;11657.067434605233;2505.110685706575;2556.8593727344987;2557.6291437741515;2562.6540417043648;2562.705288891783;2116.2169997101096;2400;2535.759102885232;2547.8089143314323;2548.3501707064675;2025.5037515808647;2157.6439887418637;2180.2042254577045;2543.504016716741;2549.388146844753;2476.1333533263396;2490.987545062272;2495.663085483473;2504.4991001799713;2506.9373265668323;2483;2488.9377765555823;2494.9251522454356;2520.0549793827313;2524.4193835417773;11623.883761162364;11747.001504872096;11751;11757.176997610171;11759.235649682743;5704.286964129484;6445.1943507061615;6786.694598743068;6786.966065169692;6795.558288711218;3512.2448673535314;3605.405108157151;3981;4288.292431748758;4351.586599273064;1217.817327400897;1245.800671892502;1247.7192631657895;1290.1613950931876;1299.3698056442618;16563.585910352216;16605.4188103417;16659;16666.999980001117;16675.082870442122;5810.448007439287;5978.8206353809455;6004.969975150097;6117.418845209698;6129.84675383119;12501.999840012777;13884.305784710725;13936.094153879965;13938;13951.930240348733;6429.614223146533;6872.244053154149;6879.415249703731;6884.862302753917;6898.379145876896;6130.908036379458;6199;6255.374462553799;6267.059941008794;6272.905906411407;3947.8156553033973;4551.249043907718;4640.048789998043;4650.348951146842;4693.06138772247;1241.9875801241872;1424.5370254667275;1442.3725679329316;1443.1052747296533;1468.7429699802492;675.3853992866566;706.20199174932;715.899774031636;779.5556532776376;810.6514198894414;6492.253390860017;6667.798946979356;7061.498892761675;7099;7216.60308683017;906.551257127726;916.4913473022536;925.5464822237055;925.7685578605349;944.1219665710955;3807.352750032446;4201.516825565038;4227.7463352198965;4253.91525161082;4345.739255644671;14724.631884202981;14883.33025013877;15380.692386152214;15397.153156576496;15404.075755454485;14852.2573871306;15080.698386032218;15109.622259443382;15124.016938899156;15142.621434464227;6948.861022779617;8693.130686931383;8729.214370706666;8746.469367860598;8749.343799215085;5883.264591926009;6131.509479241561;7012.964935175291;7034.859302813813;7057.788266352018;13215.537456188988;13866.306684665928;13889.861101388857;13898.930505347409;13907;13851;13932.442702291795;13980.720385592027;14099.718005639625;14399.568012959628;7945.682172713026;9269.72190834276;9544.85682714746;9551.90448095538;9584.185344245538;10577.418241996456;10618.256722029384;10741.946290268812;10761.192910531898;10918.617848375268;9126.908730912872;9228.861567076365;9252.814943701223;9266.768330791785;9277.814443710953;8951.686690965786;8979.191872731486;9067.274618030673;9204.401713888576;9269.119433653792;8006.519608823489;8115.959420202861;8229.300509456763;8241.95879020601;8254.587270636564;6014.82128153485;6051.425114614105;6143.846403839761;6181.041938499539;6261.5616906816085;5882.911756323744;6105.389461053859;6249.937500624936;6251.812445626639;6309.536206443408 10:17:44 INFO - PID 1635 | |4;prototype.html;382.99845902963756;398.3089339995109;406.30116200135757;408.0146446332108;408.96728261739065;5397.730113494319;5823.475887170154;6001.588832208324;6061.909071363928;6152;5950;5968.67172305523;6031.401678555187;6035.51715862731;6065.2721673399255;4443.777811109448;4447.644188464931;4463.68754187207;4463.888402789924;4486.842960496383;4369.6285815705705;4410.558944105596;4453.421055262811;4455.509893911667;4455.598996090352;3626.2928728897878;4162.458880345551;4373.497047839492;4389.341598760196;4411.713238639478;3338.966610333914;4335.82932608194;4389.407429996957;4401.493828209765;4405.713628614146;3702.685271751904;3786.0345611869075;3807.638274363931;3810.1046254130256;3821.159344944108;5086.236185222909;5944.316403613553;5958.731857066442;5973.549705469453;5986.221791167164;4512.345709872083;5209.843704688866;5218.791248350061;5226.947730522684;5253.949210157945;5106.489351064901;5322.7072511011875;5625.887482250332;5690.573207009449;6015.578909476339;4264.573542645741;4273.551277115889;4276.337167738974;4279.379489973968;4291.935620965688;6593.736250549972;6773;6787.694553745093;6832.829179270509;6913.585184888922;3596.6223546527763;4250.553691862372;4337.175936572041;4345.9130817383475;4349.434573505424;3692.984429281969;3730.7015438764834;3836.3094642964534;4400.515943246241;4412.867613971586;5175.663581867167;5184.714840683723;5224.320838290998;5283.524482796567;5526.198701188305;5089.211172268304;5982.49148822355;6496.187976502937;6584.473242140617;6588.86822263552;1557.6651020030747;1696.202784691193;1719.17479609788;1727.5249306440578;1742.7473016412803;1207.4868181023205;1208.7703336366062;1213.5740504906698;1214.40494157862;1227.1593958138703;6242.469390101892;6242.719077641426;6254.34329395416;6261.686915654199;6297.685115744286;6427.58220715652;6464.288928217892;6499.6675681485185;6656.96671516649;6792.150981127359;5441.782328706808;6006.387221558636;6192.411720886508;6196.884560779013;6197.287311959092;3195.6418522128;3423.400904841643;3484.7038001770134;3486.2330287336745;3500.544929159244;5769.826905192851;6701.6314102723845;6839.350261725128;6910.581296546168;6912.861742765217;6616.768413105518;6846.520743547904;6851.109355783717;6861.044602288324;6862.897056544156;6804.624346766098;6860.931390686129;6897.896531552031;6923.792286231421;6940.826479338057;6323.873522529616;6626.635535045619;6627.906395444697;6680.866382672417;6682.2649508555;4955.101265759571;5640.830775076754;6326;6461.095446637569;6550.279469258473;5774.538036957118;5990.682049949004;6838.982500162563;6870.381665650116;6876.724931002704;3672.412414013745;4289.871303860889;4299.204647140289;4331.350297455407;4345.739255644671;6465.870682586228;6580.901286480803;6630.867382652416;6636.203655561363;6664.333566643297;5609.242752228397;6363.5545511813725;6401.167848179707;6421.454176394872;6435.420812126931;5300.761465734128;6047.5464340173785;6159.784407545714;6460;6512.437015116243;5732.140178973187;5790.363060063474;6403.711832967434;6420.325865784025;6422.9081056221485;5353.753321744634;6339;6482.57863238888;6496.343432424702;6541.901871471837;6346.143270658402;6383.6808159592765;6393.177944285856;6394.488440924808;6410.5833120848865 10:17:44 INFO - PID 1635 | |5;yui.html;845.8646616541355;860.5009094725059;869.3132425383947;872.8603423452245;881.5371929736889;16342.83657163428;16613.66772664546;16727.916360418196;16954.576135596617;16959.067251301203;15459.536213913572;15634.29645665945;15814;15832.604184895383;15843.445479408223;958.9232861371091;960.0063933828488;960.6397600899662;962.6005207838739;963.0946909904667;992.0476342711006;997.0428388746811;1005.3766664667916;1006.2201793609975;1009.5204777730593;1027.7636143686957;1042.3120740311397;1051.1223128687554;1052.3159946035062;1053.0417320238585;1044.634377967713;1045.968620941373;1046.3878631000873;1046.70692206182;1046.7958748044134;776.6543887969856;777.0131932445819;778.5717855179629;779.5244900610624;784.000399490654;14563.126212427289;14973.550793476214;14974.700505989818;15169;15259.389624415011;13788.93105534476;13926.234057126854;14004.29978501071;14219.85780142206;14319.637259852112;10725.410102444363;12592.874071259263;12616.81074783879;12756.234625922474;12770.616881493477;3400.6769356911054;3431.24512607226;3437.432823584131;3439.8624055037767;3439.9828000860084;75346.62326688386;116127;116213.41893290564;116553;116626;11235.943820280847;13707.451701931812;13808.516701915385;13835.169889806644;13952.790708139386;25108;25149.11978080795;26000.8699956499;26586.069487567842;26612.733872661414;7612.162662107164;7663.693452261959;7835.882461763078;7859.960700196577;7863;3788.0340513168967;3888.572257051722;3893.980530097388;3902.414637804352;3903.33643280643;4235.53409124996;4386.320120381346;4460.776961151994;4467.396901418332;4467.7319360838455;946.5929650250321;951.752544338477;959.0792838874619;964.9228061755183;967.7048500207363;642.563057121162;661.2461793555351;664.2062735031687;680.7481231944213;697.7941507255372;11138.49876755548;11655.88344116548;11877.287362758263;12011.279323240633;12157;645.8805121052526;647.970841312142;652.3574279334852;662.5163630549725;685.3283781893672;5151.531813433154;5404.486913585123;5497.367802702661;5555.666580067554;5635.830925072254;100011.9994000297;107493.46253268684;108942;109401.35897961537;112218.70578412377;72818.2718172822;97904.51047744715;98897.516537252;99668;100977;61320;68337;84395.57802211073;86552.56723716467;86680.69978950321;11748.882511175121;12630.557930472389;12814.231146131262;13004.869951300745;13059.608211753282;32019.519707203945;42380.57619423766;42696.57303426926;42983.71048868539;43215;65086;65521.34478655343;69304;69841.65079174774;69957;16772.32910683559;17182.828171718622;17500.299988000337;17523.649527009642;17550.210240538952;15589.59693627579;18607.348742793936;18659.81340186581;18739.063046847332;18786;17226.224819882886;17521.912390437967;17751.73372399441;17773.822261777736;17887.463376098738;16054.036757794569;16305.755413669041;17368.826311737226;17497.82502174962;17513.03678297655;16113.919430402773;16771.161441927612;16816.243269052677;17114.315427382764;17281.913590431966;9528.666496672584;11012.39431831225;11292.887071129184;11584.362860042442;12249.816252756038;11602;12405.255684658949;13080.476780928657;13120.803187951997;13206.27365494907 10:17:44 INFO - PID 1635 | __end_tp_report 10:17:44 INFO - PID 1635 | __start_cc_report 10:17:44 INFO - PID 1635 | _x_x_mozilla_cycle_collect,1960 10:17:44 INFO - PID 1635 | __end_cc_report 10:17:44 INFO - PID 1635 | __startTimestamp1494350264338__endTimestamp 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | ------- Summary: start ------- 10:17:44 INFO - PID 1635 | Number of tests: 6 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:6136.51 Median:6393.58 stddev:752.76 (11.8%) stddev-sans-first:724.46 10:17:44 INFO - PID 1635 | Values: 3428.0 3593.6 3601.1 3618.0 3618.1 4974.7 6113.1 6158.6 6229.5 6278.0 6204.0 6223.4 6281.6 6284.4 6309.6 4947.8 5229.6 5359.6 5427.7 5449.9 5459.2 5464.5 5509.2 5517.5 5581.6 5341.9 5432.5 5436.1 5454.3 5531.0 5407.2 5417.2 5454.2 5489.3 5508.7 5414.5 5416.9 5425.3 5433.0 5444.8 6117.3 6178.7 6198.9 6233.4 6269.0 6037.0 6304.2 6598.8 6694.1 6707.5 6643.2 6716.8 6723.9 6729.6 6741.1 6188.8 6190.4 6321.3 6342.7 6351.5 6714.2 6839.7 6924.0 6955.1 6963.3 6393.6 6466.4 6469.5 6496.2 6584.4 6667.3 6675.0 6707.6 6721.2 6722.7 6598.9 6600.1 6605.5 6606.3 6617.2 6432.0 6518.4 6602.6 6665.1 6667.7 5301.3 5316.8 5338.6 5351.8 5361.8 3899.7 4214.0 4450.6 4685.0 4714.6 6145.8 6287.5 6307.6 6350.6 6352.6 6733.9 6762.5 6768.1 6769.9 6782.7 6351.7 6368.2 6368.6 6372.9 6398.9 5197.5 5485.4 5804.2 5842.7 5874.5 6762.3 6894.1 6932.3 6937.1 6963.6 6747.9 6749.6 6759.9 6764.6 6769.1 6864.2 6874.6 6910.8 6911.3 6951.0 6451.7 6556.6 6593.3 6629.2 6634.3 5994.7 6699.6 6730.0 6736.2 6754.2 6060.6 6376.6 6441.7 6445.5 6499.2 6536.1 6539.5 6546.9 6551.0 6555.5 6303.1 6427.1 6441.3 6445.2 6447.8 6428.0 6432.2 6476.3 6533.9 6543.8 6376.2 6391.4 6398.6 6406.3 6416.6 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:44710.28 Median:319069.00 stddev:78658.67 (24.7%) stddev-sans-first:78810.09 10:17:44 INFO - PID 1635 | Values: 755.4 799.4 805.5 1131.0 1152.1 26147.6 36852.6 37073.6 37192.0 37210.3 39105.6 39354.8 39443.4 39453.8 39483.8 5181.8 5941.7 8132.4 8286.3 8294.2 5889.7 5948.8 5959.6 5963.2 8222.3 8382.2 8427.1 8430.3 8440.0 8512.1 8332.4 8392.5 8398.0 8398.3 8405.5 8259.8 8308.3 8312.6 8328.5 8338.9 37027.4 37153.3 37195.3 37237.8 37262.5 3603.6 3637.7 3637.8 3638.0 3644.1 30652.4 30690.7 30696.0 30712.7 30761.8 3059.8 3116.4 3129.7 3141.7 3150.0 297035.0 297149.0 297237.0 297752.0 298966.0 48989.0 49016.0 49105.0 49213.0 49280.8 51854.7 51951.7 51983.7 51986.2 52003.0 13924.4 14002.9 14033.4 14042.3 14095.3 11384.3 11394.0 11406.1 11409.1 11410.6 10558.5 10608.2 10637.0 12160.4 12490.9 4892.8 5138.7 5456.5 5484.1 5494.9 909.4 1018.9 1031.0 1061.9 1080.6 24111.3 24287.0 24293.5 24335.5 24339.0 1090.6 1093.7 1107.5 1108.9 1191.4 11922.3 12428.1 12435.3 12444.8 12456.6 317017.0 317406.0 318066.8 318613.0 319525.0 52369.7 52392.7 52471.2 52473.7 52535.9 1528.5 1579.1 1599.6 1610.4 1611.1 23850.9 23956.4 23986.4 24000.9 24035.5 37914.6 37920.0 37950.7 37959.0 37965.2 281729.2 281991.0 282434.0 282579.0 282788.0 32805.5 33920.8 33930.0 34089.7 34176.0 37627.2 37631.0 37680.8 43763.0 44509.9 27711.9 30652.5 30730.9 30769.8 31064.2 29764.6 30284.5 30629.5 31017.4 31018.2 36635.6 36639.8 36805.4 37383.8 37518.8 25478.7 29124.8 29906.9 31282.4 31468.7 22569.8 24033.9 24350.5 24532.3 24589.8 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:35331.08 Median:12404.39 stddev:93751.63 (755.8%) stddev-sans-first:93978.02 10:17:44 INFO - PID 1635 | Values: 439.1 442.9 443.3 448.3 461.6 19195.9 21206.7 21849.9 21931.7 21989.0 22068.9 22490.0 22665.4 22821.0 23242.8 6016.8 6121.6 6229.6 6238.5 6238.7 5879.8 6200.0 6215.5 6217.0 6220.1 5873.8 6088.4 6164.4 6166.8 6180.1 6064.5 6148.5 6148.8 6149.7 6171.6 5240.9 5459.7 5469.2 5529.4 5532.2 27056.5 27113.0 27321.0 27637.9 27670.4 2188.2 2248.8 2249.8 2252.1 2254.1 14512.9 17638.0 17657.6 18090.9 18301.9 2115.4 2132.6 2196.7 2199.5 2201.3 110518.0 131745.7 132255.0 132387.0 133564.3 10523.7 11845.3 12396.9 12485.7 12592.8 16551.1 16596.0 16623.9 16624.9 16652.7 7143.5 8907.5 8946.7 8973.7 9076.0 8328.5 8384.5 8534.3 8555.5 8579.5 6180.5 7686.5 7720.6 7731.4 7733.7 1752.8 2079.9 2082.8 2088.4 2096.6 995.0 1004.3 1007.8 1040.2 1054.9 20350.9 25267.5 26499.1 26790.9 26821.3 871.9 1031.1 1031.5 1039.5 1050.8 13004.5 13865.2 13890.9 14116.4 14203.5 551413.0 552009.0 559922.0 565499.0 567693.0 122648.4 123250.3 123364.0 125609.0 126994.4 1165.5 1210.2 1244.0 1255.9 1257.9 22554.7 23091.0 23303.0 23757.9 23799.5 56882.7 57762.4 58239.4 58264.7 60542.7 76804.0 77795.2 79501.0 79879.0 81285.6 8452.2 8499.6 8707.5 9011.8 9235.0 13751.4 13979.5 13985.4 14399.2 14400.6 11729.7 11890.9 12004.5 12045.6 12148.9 11030.1 11085.6 11223.9 11240.9 11379.3 11795.8 12101.4 12171.2 12201.9 12278.0 8570.9 8840.8 8895.0 8906.5 9009.7 11560.0 11681.4 11842.0 11941.8 12013.9 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7159.24 Median:3877.58 stddev:4569.44 (117.8%) stddev-sans-first:4560.00 10:17:44 INFO - PID 1635 | Values: 1157.6 1373.7 1410.6 1423.1 1439.2 9816.2 10223.1 10237.4 10249.6 10253.7 9274.8 10046.5 11649.6 11655.7 11657.1 2505.1 2556.9 2557.6 2562.7 2562.7 2116.2 2400.0 2535.8 2547.8 2548.4 2025.5 2157.6 2180.2 2543.5 2549.4 2476.1 2491.0 2495.7 2504.5 2506.9 2483.0 2488.9 2494.9 2520.1 2524.4 11623.9 11747.0 11751.0 11757.2 11759.2 5704.3 6445.2 6786.7 6787.0 6795.6 3512.2 3605.4 3981.0 4288.3 4351.6 1217.8 1245.8 1247.7 1290.2 1299.4 16563.6 16605.4 16659.0 16667.0 16675.1 5810.4 5978.8 6005.0 6117.4 6129.8 12502.0 13884.3 13936.1 13938.0 13951.9 6429.6 6872.2 6879.4 6884.9 6898.4 6130.9 6199.0 6255.4 6267.1 6272.9 3947.8 4551.2 4640.0 4650.3 4693.1 1242.0 1424.5 1442.4 1443.1 1468.7 675.4 706.2 715.9 779.6 810.7 6492.3 6667.8 7061.5 7099.0 7216.6 906.6 916.5 925.5 925.8 944.1 3807.4 4201.5 4227.7 4253.9 4345.7 14724.6 14883.3 15380.7 15397.2 15404.1 14852.3 15080.7 15109.6 15124.0 15142.6 6948.9 8693.1 8729.2 8746.5 8749.3 5883.3 6131.5 7013.0 7034.9 7057.8 13215.5 13866.3 13889.9 13898.9 13907.0 13851.0 13932.4 13980.7 14099.7 14399.6 7945.7 9269.7 9544.9 9551.9 9584.2 10577.4 10618.3 10741.9 10761.2 10918.6 9126.9 9228.9 9252.8 9266.8 9277.8 8951.7 8979.2 9067.3 9204.4 9269.1 8006.5 8116.0 8229.3 8242.0 8254.6 6014.8 6051.4 6143.8 6181.0 6261.6 5882.9 6105.4 6249.9 6251.8 6309.5 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5190.88 Median:5782.45 stddev:1622.94 (28.1%) stddev-sans-first:1586.87 10:17:44 INFO - PID 1635 | Values: 383.0 398.3 406.3 408.0 409.0 5397.7 5823.5 6001.6 6061.9 6152.0 5950.0 5968.7 6031.4 6035.5 6065.3 4443.8 4447.6 4463.7 4463.9 4486.8 4369.6 4410.6 4453.4 4455.5 4455.6 3626.3 4162.5 4373.5 4389.3 4411.7 3339.0 4335.8 4389.4 4401.5 4405.7 3702.7 3786.0 3807.6 3810.1 3821.2 5086.2 5944.3 5958.7 5973.5 5986.2 4512.3 5209.8 5218.8 5226.9 5253.9 5106.5 5322.7 5625.9 5690.6 6015.6 4264.6 4273.6 4276.3 4279.4 4291.9 6593.7 6773.0 6787.7 6832.8 6913.6 3596.6 4250.6 4337.2 4345.9 4349.4 3693.0 3730.7 3836.3 4400.5 4412.9 5175.7 5184.7 5224.3 5283.5 5526.2 5089.2 5982.5 6496.2 6584.5 6588.9 1557.7 1696.2 1719.2 1727.5 1742.7 1207.5 1208.8 1213.6 1214.4 1227.2 6242.5 6242.7 6254.3 6261.7 6297.7 6427.6 6464.3 6499.7 6657.0 6792.2 5441.8 6006.4 6192.4 6196.9 6197.3 3195.6 3423.4 3484.7 3486.2 3500.5 5769.8 6701.6 6839.4 6910.6 6912.9 6616.8 6846.5 6851.1 6861.0 6862.9 6804.6 6860.9 6897.9 6923.8 6940.8 6323.9 6626.6 6627.9 6680.9 6682.3 4955.1 5640.8 6326.0 6461.1 6550.3 5774.5 5990.7 6839.0 6870.4 6876.7 3672.4 4289.9 4299.2 4331.4 4345.7 6465.9 6580.9 6630.9 6636.2 6664.3 5609.2 6363.6 6401.2 6421.5 6435.4 5300.8 6047.5 6159.8 6460.0 6512.4 5732.1 5790.4 6403.7 6420.3 6422.9 5353.8 6339.0 6482.6 6496.3 6541.9 6346.1 6383.7 6393.2 6394.5 6410.6 10:17:44 INFO - PID 1635 | 10:17:44 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21577.62 Median:17762.78 stddev:30064.36 (169.3%) stddev-sans-first:30108.39 10:17:44 INFO - PID 1635 | Values: 845.9 860.5 869.3 872.9 881.5 16342.8 16613.7 16727.9 16954.6 16959.1 15459.5 15634.3 15814.0 15832.6 15843.4 958.9 960.0 960.6 962.6 963.1 992.0 997.0 1005.4 1006.2 1009.5 1027.8 1042.3 1051.1 1052.3 1053.0 1044.6 1046.0 1046.4 1046.7 1046.8 776.7 777.0 778.6 779.5 784.0 14563.1 14973.6 14974.7 15169.0 15259.4 13788.9 13926.2 14004.3 14219.9 14319.6 10725.4 12592.9 12616.8 12756.2 12770.6 3400.7 3431.2 3437.4 3439.9 3440.0 75346.6 116127.0 116213.4 116553.0 116626.0 11235.9 13707.5 13808.5 13835.2 13952.8 25108.0 25149.1 26000.9 26586.1 26612.7 7612.2 7663.7 7835.9 7860.0 7863.0 3788.0 3888.6 3894.0 3902.4 3903.3 4235.5 4386.3 4460.8 4467.4 4467.7 946.6 951.8 959.1 964.9 967.7 642.6 661.2 664.2 680.7 697.8 11138.5 11655.9 11877.3 12011.3 12157.0 645.9 648.0 652.4 662.5 685.3 5151.5 5404.5 5497.4 5555.7 5635.8 100012.0 107493.5 108942.0 109401.4 112218.7 72818.3 97904.5 98897.5 99668.0 100977.0 61320.0 68337.0 84395.6 86552.6 86680.7 11748.9 12630.6 12814.2 13004.9 13059.6 32019.5 42380.6 42696.6 42983.7 43215.0 65086.0 65521.3 69304.0 69841.7 69957.0 16772.3 17182.8 17500.3 17523.6 17550.2 15589.6 18607.3 18659.8 18739.1 18786.0 17226.2 17521.9 17751.7 17773.8 17887.5 16054.0 16305.8 17368.8 17497.8 17513.0 16113.9 16771.2 16816.2 17114.3 17281.9 9528.7 11012.4 11292.9 11584.4 12249.8 11602.0 12405.3 13080.5 13120.8 13206.3 10:17:44 INFO - PID 1635 | -------- Summary: end -------- 10:17:44 INFO - PID 1635 | 10:17:45 INFO - TEST-INFO | 1635: exit 0 10:17:45 INFO - TEST-OK | dromaeo_css | took 1118127ms 10:17:45 INFO - TEST-START | kraken 10:17:45 INFO - operating with platform_type : mac_ 10:17:45 INFO - Initialising browser for kraken test... 10:17:45 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmp8lUanv/profile http://localhost:49243/getInfo.html) 10:17:47 INFO - PID 1645 | __metrics Screen width/height:1600/1200 10:17:47 INFO - PID 1645 | colorDepth:24 10:17:47 INFO - PID 1645 | Browser inner width/height: 1024/691 10:17:47 INFO - PID 1645 | __metrics 10:17:47 INFO - PID 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:17:47 INFO - PID 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:48 INFO - TEST-INFO | 1645: exit 0 10:17:48 INFO - Browser initialized. 10:17:48 INFO - Running cycle 1/1 for kraken test... 10:17:48 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/T/tmp8lUanv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:00 INFO - PID 1646 | RSS: Main: 234614784 10:18:00 INFO - PID 1646 | 10:18:02 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:18:03 INFO - PID 1646 | RSS: Main: 303583232 10:18:03 INFO - PID 1646 | 10:18:06 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:18:06 INFO - PID 1646 | RSS: Main: 286085120 10:18:06 INFO - PID 1646 | 10:18:10 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:18:10 INFO - PID 1646 | RSS: Main: 375730176 10:18:10 INFO - PID 1646 | 10:18:12 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:18:13 INFO - PID 1646 | RSS: Main: 280236032 10:18:13 INFO - PID 1646 | 10:18:15 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:15 INFO - PID 1646 | RSS: Main: 282476544 10:18:15 INFO - PID 1646 | 10:18:18 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:19 INFO - PID 1646 | RSS: Main: 347721728 10:18:19 INFO - PID 1646 | 10:18:22 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:22 INFO - PID 1646 | RSS: Main: 366854144 10:18:22 INFO - PID 1646 | 10:18:25 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:18:26 INFO - PID 1646 | RSS: Main: 377286656 10:18:26 INFO - PID 1646 | 10:18:27 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:28 INFO - PID 1646 | RSS: Main: 325464064 10:18:28 INFO - PID 1646 | 10:18:30 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:30 INFO - PID 1646 | RSS: Main: 327380992 10:18:30 INFO - PID 1646 | 10:18:32 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:33 INFO - PID 1646 | RSS: Main: 329068544 10:18:33 INFO - PID 1646 | 10:18:36 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:37 INFO - PID 1646 | RSS: Main: 347172864 10:18:37 INFO - PID 1646 | 10:18:40 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:40 INFO - PID 1646 | RSS: Main: 339943424 10:18:40 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:18:42 INFO - PID 1646 | RSS: Main: 382705664 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | __start_tp_report 10:18:42 INFO - PID 1646 | _x_x_mozilla_page_load 10:18:42 INFO - PID 1646 | _x_x_mozilla_page_load_details 10:18:42 INFO - PID 1646 | |i|pagename|runs| 10:18:42 INFO - PID 1646 | |0;ai-astar;108;109;108;109;109;108;109;109;108;110 10:18:42 INFO - PID 1646 | |1;audio-beat-detection;140;109;109;142;109;107;105;99;164;143 10:18:42 INFO - PID 1646 | |2;audio-dft;188;183;181;184;184;186;183;186;184;181 10:18:42 INFO - PID 1646 | |3;audio-fft;81;57;57;88;63;56;57;57;78;57 10:18:42 INFO - PID 1646 | |4;audio-oscillator;87;71;85;69;69;68;87;72;98;117 10:18:42 INFO - PID 1646 | |5;imaging-gaussian-blur;107;86;88;87;88;87;87;86;88;86 10:18:42 INFO - PID 1646 | |6;imaging-darkroom;94;101;93;123;151;96;94;94;94;93 10:18:42 INFO - PID 1646 | |7;imaging-desaturate;84;83;85;86;84;83;85;86;86;83 10:18:42 INFO - PID 1646 | |8;json-parse-financial;48;49;47;46;48;50;48;47;47;48 10:18:42 INFO - PID 1646 | |9;json-stringify-tinderbox;55;61;60;68;61;60;56;57;57;57 10:18:42 INFO - PID 1646 | |10;stanford-crypto-aes;82;82;81;82;81;82;80;81;88;88 10:18:42 INFO - PID 1646 | |11;stanford-crypto-ccm;137;137;139;147;139;135;134;136;175;155 10:18:42 INFO - PID 1646 | |12;stanford-crypto-pbkdf2;186;181;184;184;186;183;186;185;230;178 10:18:42 INFO - PID 1646 | |13;stanford-crypto-sha256-iterative;68;68;67;66;69;68;65;68;68;68 10:18:42 INFO - PID 1646 | __end_tp_report 10:18:42 INFO - PID 1646 | __start_cc_report 10:18:42 INFO - PID 1646 | _x_x_mozilla_cycle_collect,2161 10:18:42 INFO - PID 1646 | __end_cc_report 10:18:42 INFO - PID 1646 | __startTimestamp1494350322874__endTimestamp 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | ------- Summary: start ------- 10:18:42 INFO - PID 1646 | Number of tests: 14 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#0] ai-astar Cycles:10 Average:108.70 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 10:18:42 INFO - PID 1646 | Values: 108.0 109.0 108.0 109.0 109.0 108.0 109.0 109.0 108.0 110.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#1] audio-beat-detection Cycles:10 Average:122.70 Median:141.00 stddev:22.30 (15.8%) stddev-sans-first:22.75 10:18:42 INFO - PID 1646 | Values: 140.0 109.0 109.0 142.0 109.0 107.0 105.0 99.0 164.0 143.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:2.21 (1.2%) stddev-sans-first:1.81 10:18:42 INFO - PID 1646 | Values: 188.0 183.0 181.0 184.0 184.0 186.0 183.0 186.0 184.0 181.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#3] audio-fft Cycles:10 Average:65.10 Median:60.00 stddev:12.29 (20.5%) stddev-sans-first:11.61 10:18:42 INFO - PID 1646 | Values: 81.0 57.0 57.0 88.0 63.0 56.0 57.0 57.0 78.0 57.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#4] audio-oscillator Cycles:10 Average:82.30 Median:78.50 stddev:15.97 (20.3%) stddev-sans-first:16.84 10:18:42 INFO - PID 1646 | Values: 87.0 71.0 85.0 69.0 69.0 68.0 87.0 72.0 98.0 117.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:87.00 stddev:6.38 (7.3%) stddev-sans-first:0.87 10:18:42 INFO - PID 1646 | Values: 107.0 86.0 88.0 87.0 88.0 87.0 87.0 86.0 88.0 86.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:94.00 stddev:19.09 (20.3%) stddev-sans-first:19.95 10:18:42 INFO - PID 1646 | Values: 94.0 101.0 93.0 123.0 151.0 96.0 94.0 94.0 94.0 93.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:1.27 (1.5%) stddev-sans-first:1.33 10:18:42 INFO - PID 1646 | Values: 84.0 83.0 85.0 86.0 84.0 83.0 85.0 86.0 86.0 83.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#8] json-parse-financial Cycles:10 Average:47.80 Median:48.00 stddev:1.14 (2.4%) stddev-sans-first:1.20 10:18:42 INFO - PID 1646 | Values: 48.0 49.0 47.0 46.0 48.0 50.0 48.0 47.0 47.0 48.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:60.00 stddev:3.77 (6.3%) stddev-sans-first:3.67 10:18:42 INFO - PID 1646 | Values: 55.0 61.0 60.0 68.0 61.0 60.0 56.0 57.0 57.0 57.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:2.87 (3.5%) stddev-sans-first:3.03 10:18:42 INFO - PID 1646 | Values: 82.0 82.0 81.0 82.0 81.0 82.0 80.0 81.0 88.0 88.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:139.00 stddev:12.83 (9.2%) stddev-sans-first:13.39 10:18:42 INFO - PID 1646 | Values: 137.0 137.0 139.0 147.0 139.0 135.0 134.0 136.0 175.0 155.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.30 Median:185.50 stddev:14.87 (8.0%) stddev-sans-first:15.75 10:18:42 INFO - PID 1646 | Values: 186.0 181.0 184.0 184.0 186.0 183.0 186.0 185.0 230.0 178.0 10:18:42 INFO - PID 1646 | 10:18:42 INFO - PID 1646 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 10:18:42 INFO - PID 1646 | Values: 68.0 68.0 67.0 66.0 69.0 68.0 65.0 68.0 68.0 68.0 10:18:42 INFO - PID 1646 | -------- Summary: end -------- 10:18:42 INFO - PID 1646 | 10:18:43 INFO - TEST-INFO | 1646: exit 0 10:18:43 INFO - TEST-OK | kraken | took 58777ms 10:18:43 INFO - SUITE-END | took 1176s 10:18:44 INFO - Completed test suite (00:19:37) 10:18:44 INFO - javascript benchmark 10:18:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7842.657469644057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3427.954473885464, 3593.6047034826165, 3601.083122670637, 3617.986963650177, 3618.149734812317, 4974.7263900485505, 6113.144159817629, 6158.59969102008, 6229.501639868811, 6277.968610156943, 6204.00735882259, 6223.408776166269, 6281.560290779647, 6284.402981716729, 6309.589876658014, 4947.77735001924, 5229.555487783543, 5359.624826262163, 5427.674339539641, 5449.891002179954, 5459.235707001023, 5464.453554644543, 5509.228707980886, 5517.503424691777, 5581.581381396391, 5341.919871201916, 5432.456754324576, 5436.130219164954, 5454.263674403945, 5530.972345138289, 5407.242985981966, 5417.187421886709, 5454.236406903036, 5489.286392768954, 5508.669479831223, 5414.458554144593, 5416.864578385533, 5425.348958125051, 5433.0, 5444.754986025639, 6117.256581874144, 6178.691065446755, 6198.876022479525, 6233.391390893257, 6269.0, 6037.0, 6304.211973503312, 6598.769043083469, 6694.096296999892, 6707.49693772969, 6643.236027856762, 6716.798496045127, 6723.93276067238, 6729.5625784323865, 6741.123653925008, 6188.752449901998, 6190.380961903774, 6321.273053598849, 6342.682865856688, 6351.523635727339, 6714.194296684332, 6839.658017099126, 6923.965380173167, 6955.095837541087, 6963.303669633097, 6393.584417012879, 6466.418022378009, 6469.514786390945, 6496.187976502937, 6584.440322572635, 6667.299933507009, 6674.966625166843, 6707.5975441473665, 6721.1598550181225, 6722.697478613474, 6598.934010659832, 6600.075989361493, 6605.5376123670885, 6606.306337834458, 6617.239017512951, 6432.0, 6518.44593209573, 6602.570832895846, 6665.1335326408225, 6667.699953502104, 5301.284326615858, 5316.840494785162, 5338.599605029638, 5351.812686555952, 5361.8123365682795, 3899.6880249579967, 4214.009707718745, 4450.554944505524, 4684.95315046852, 4714.57568818808, 6145.801568694062, 6287.528435367366, 6307.590006649553, 6350.618962862243, 6352.587081839665, 6733.8989915151315, 6762.492813039042, 6768.120144381297, 6769.8646027079185, 6782.728690852311, 6351.745930162741, 6368.203974503187, 6368.5860419072615, 6372.936270637234, 6398.8720225595225, 5197.506236907488, 5485.396606373296, 5804.158397032406, 5842.737076831553, 5874.471297583238, 6762.256151823295, 6894.13823272091, 6932.341427564374, 6937.098177236927, 6963.582185068912, 6747.865042699217, 6749.5612785168805, 6759.86480270382, 6764.5603035802515, 6769.120014398097, 6864.176298844171, 6874.553154044971, 6910.792676219721, 6911.343422374866, 6950.965245173742, 6451.6774161290805, 6556.63938483388, 6593.307702691341, 6629.204495460575, 6634.303398143125, 5994.681170142561, 6699.598024118569, 6729.990501424825, 6736.191657001191, 6754.189497260164, 6060.575759696955, 6376.585521941059, 6441.742330306923, 6445.484361251182, 6499.1876015498065, 6536.0522724205675, 6539.509536784665, 6546.869062618816, 6551.0, 6555.541112122296, 6303.086052522451, 6427.068075129174, 6441.323661015714, 6445.16212892321, 6447.774327898501, 6428.003659432796, 6432.2281326241155, 6476.319986401549, 6533.869322613426, 6543.803685889431, 6376.171097757262, 6391.392817682313, 6398.584092034003, 6406.295307516077, 6416.647084410402], "value": 6083.992850643073, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.4485225785177, 799.3605115907272, 805.5327909812311, 1131.0103659298113, 1152.0898490192749, 26147.607785883203, 36852.63147368526, 37073.62926370736, 37192.0, 37210.25579488412, 39105.60894391055, 39354.80322598383, 39443.40834887472, 39453.802730986376, 39483.81548553541, 5181.766820493068, 5941.673207973559, 8132.430729848898, 8286.337093032573, 8294.170582941719, 5889.676067816268, 5948.791792287271, 5959.553033522481, 5963.194968679238, 8222.301104406102, 8382.203690649378, 8427.115152908947, 8430.283425908805, 8439.987201535825, 8512.1487851215, 8332.375071869603, 8392.538410387426, 8397.958010209972, 8398.328133749286, 8405.495670259805, 8259.83480330396, 8308.29379502743, 8312.625931833081, 8328.458650187718, 8338.874916876252, 37027.4445883312, 37153.25693486115, 37195.25609487822, 37237.81381093077, 37262.528496580315, 3603.6396360364015, 3637.727170462226, 3637.763545369569, 3638.0177352115047, 3644.0707619556842, 30652.38695226105, 30690.693093069007, 30696.0, 30712.69287307143, 30761.8461907689, 3059.8011129276524, 3116.376724655078, 3129.6557378688326, 3141.7329526990234, 3149.9685003149903, 297035.0, 297149.0, 297237.0, 297752.0, 298966.0, 48989.0, 49016.0, 49105.0178996418, 49213.0, 49280.75359623179, 51854.74072629613, 51951.740241298554, 51983.74008129935, 51986.22020669693, 52003.0, 13924.37340319688, 14002.949778766633, 14033.368498417596, 14042.297885105703, 14095.295235238196, 11384.260023098472, 11394.0, 11406.14453915943, 11409.144314176305, 11410.600628977945, 10558.472076396149, 10608.151347892304, 10637.0, 12160.391980400944, 12490.93827024713, 4892.801263690348, 5138.691678499302, 5456.48163424474, 5484.122540393518, 5494.917576236359, 909.3589019741066, 1018.9453915197735, 1030.9845352319721, 1061.8991195836384, 1080.5839751695653, 24111.276661700176, 24287.0, 24293.51412971766, 24335.513289734106, 24339.0, 1090.6455401994383, 1093.6828319787173, 1107.534835369147, 1108.855848739675, 1191.4042978510745, 11922.344271065002, 12428.067894907917, 12435.316057616918, 12444.751104978031, 12456.626301210978, 317017.0, 317406.0, 318066.81933180836, 318613.0, 319525.0, 52369.738151309, 52392.73803630957, 52471.212931806054, 52473.7376313116, 52535.94928101417, 1528.5108765195253, 1579.1314776872673, 1599.5841081318708, 1610.4363472784432, 1611.129989805492, 23850.880745596856, 23956.40108997289, 23986.40033999164, 24000.87999559991, 24035.519289614458, 37914.62085379111, 37920.0, 37950.67172648944, 37959.0, 37965.24069518539, 281729.1827081703, 281991.0, 282434.0, 282579.0, 282788.0, 32805.507917381736, 33920.830395847865, 33929.982100537025, 34089.65910340964, 34175.974720758415, 37627.2474550502, 37631.0, 37680.81159594184, 43763.0, 44509.88725281894, 27711.8915243388, 30652.540211896394, 30730.924417645274, 30769.846150769103, 31064.22339441532, 29764.55353169661, 30284.54573181448, 30629.54055689211, 31017.37965240728, 31018.224544385666, 36635.63364366322, 36639.816800915825, 36805.44791828071, 37383.813080935506, 37518.812405937795, 25478.745212547637, 29124.762772904454, 29906.85046574753, 31282.374352513278, 31468.685313147493, 22569.774302257425, 24033.91847366838, 24350.51298974046, 24532.264032079067, 24589.754102458748], "value": 17104.621436780493, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.14147840970907, 442.8671398580427, 443.29958665308806, 448.27379644975133, 461.6422272738627, 19195.904020479895, 21206.681899771516, 21849.907504624745, 21931.67102493464, 21989.0, 22068.8896555517, 22489.987950542225, 22665.433364165903, 22821.0, 23242.83785810707, 6016.75932962681, 6121.571489995702, 6229.563930524865, 6238.4697300729495, 6238.719257633395, 5879.7648094076185, 6200.038993955944, 6215.50275977923, 6216.968915155418, 6220.098085777559, 5873.794417195399, 6088.4215999479975, 6164.383561643845, 6166.81499555014, 6180.072989051656, 6064.4541991220785, 6148.477379422754, 6148.754049838046, 6149.6617686027475, 6171.59884607499, 5240.947590524084, 5459.672419654833, 5469.206964990094, 5529.4470552944385, 5532.170174473821, 27056.458870822473, 27113.0, 27321.0, 27637.894484220607, 27670.446591068267, 2188.1794327127327, 2248.7751224877543, 2249.8312626553075, 2252.110416385535, 2254.120892851789, 14512.854871451256, 17638.0, 17657.55856103595, 18090.90954545232, 18301.908490457594, 2115.4076858479652, 2132.5734853029303, 2196.736391632998, 2199.549092436047, 2201.306588424657, 110518.0, 131745.6825431743, 132255.0, 132387.0, 133564.3321783385, 10523.684289471328, 11845.348505832262, 12396.938015309866, 12485.687857803447, 12592.773998790399, 16551.08969006692, 16596.0, 16623.91688041552, 16624.916875415547, 16652.666946661, 7143.535670181422, 8907.51008694528, 8946.68686595966, 8973.730788076238, 9076.047015063323, 8328.541930193776, 8384.53885036329, 8534.317254619615, 8555.529445880537, 8579.528125953007, 6180.505559555315, 7686.538807671446, 7720.575368354682, 7731.381489480828, 7733.651985660659, 1752.7633769440963, 2079.906404211814, 2082.802133797287, 2088.3630492699567, 2096.6330892093824, 995.0, 1004.2769206171545, 1007.7883644434751, 1040.1626690514208, 1054.857594224785, 20350.880701561557, 25267.494650106895, 26499.145044978144, 26790.866045669645, 26821.329466763487, 871.8735783311384, 1031.0771859185986, 1031.489412740698, 1039.5322105052605, 1050.8003479338902, 13004.479820807252, 13865.237411942238, 13890.930545347208, 14116.435342586181, 14203.502877399242, 551413.0, 552009.0, 559922.0, 565499.0, 567693.0, 122648.38675806564, 123250.27128537161, 123364.0, 125609.0, 126994.36502817427, 1165.4988355007429, 1210.2375503432781, 1243.9689007774878, 1255.8744125587368, 1257.8553466351304, 22554.661680074485, 23091.0, 23303.0, 23757.881210593838, 23799.524009519366, 56882.7155864218, 57762.42237577739, 58239.4176058234, 58264.70867645634, 60542.697286513285, 76804.0, 77795.22204778106, 79501.0, 79879.0, 81285.59357203412, 8452.239298463168, 8499.617517211616, 8707.47755134694, 9011.819763604823, 9235.030321816113, 13751.449942002208, 13979.510717124851, 13985.370658320197, 14399.208043557286, 14400.567982960529, 11729.706757331134, 11890.881091188978, 12004.519819207135, 12045.578404755792, 12148.939255303667, 11030.117590592572, 11085.556577736801, 11223.887761122285, 11240.887591123985, 11379.260348077349, 11795.823062654239, 12101.369589123404, 12171.208871423683, 12201.938990305347, 12278.0, 8570.914290857012, 8840.778980525538, 8895.021547629885, 8906.465612063297, 9009.684661036832, 11560.0, 11681.415929203336, 11842.0, 11941.761164776482, 12013.879861201625], "value": 10567.378717024034, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1157.5774842182607, 1373.711520580678, 1410.5838777560618, 1423.096333828019, 1439.1940513312545, 9816.214702823774, 10223.131033862112, 10237.436940968244, 10249.590016399345, 10253.743656408584, 9274.768130796734, 10046.497675116234, 11649.592264270752, 11655.708607284821, 11657.067434605233, 2505.110685706575, 2556.8593727344987, 2557.6291437741515, 2562.6540417043648, 2562.705288891783, 2116.2169997101096, 2400.0, 2535.759102885232, 2547.8089143314323, 2548.3501707064675, 2025.5037515808647, 2157.6439887418637, 2180.2042254577045, 2543.504016716741, 2549.388146844753, 2476.1333533263396, 2490.987545062272, 2495.663085483473, 2504.4991001799713, 2506.9373265668323, 2483.0, 2488.9377765555823, 2494.9251522454356, 2520.0549793827313, 2524.4193835417773, 11623.883761162364, 11747.001504872096, 11751.0, 11757.176997610171, 11759.235649682743, 5704.286964129484, 6445.1943507061615, 6786.694598743068, 6786.966065169692, 6795.558288711218, 3512.2448673535314, 3605.405108157151, 3981.0, 4288.292431748758, 4351.586599273064, 1217.817327400897, 1245.800671892502, 1247.7192631657895, 1290.1613950931876, 1299.3698056442618, 16563.585910352216, 16605.4188103417, 16659.0, 16666.999980001117, 16675.082870442122, 5810.448007439287, 5978.8206353809455, 6004.969975150097, 6117.418845209698, 6129.84675383119, 12501.999840012777, 13884.305784710725, 13936.094153879965, 13938.0, 13951.930240348733, 6429.614223146533, 6872.244053154149, 6879.415249703731, 6884.862302753917, 6898.379145876896, 6130.908036379458, 6199.0, 6255.374462553799, 6267.059941008794, 6272.905906411407, 3947.8156553033973, 4551.249043907718, 4640.048789998043, 4650.348951146842, 4693.06138772247, 1241.9875801241872, 1424.5370254667275, 1442.3725679329316, 1443.1052747296533, 1468.7429699802492, 675.3853992866566, 706.20199174932, 715.899774031636, 779.5556532776376, 810.6514198894414, 6492.253390860017, 6667.798946979356, 7061.498892761675, 7099.0, 7216.60308683017, 906.551257127726, 916.4913473022536, 925.5464822237055, 925.7685578605349, 944.1219665710955, 3807.352750032446, 4201.516825565038, 4227.7463352198965, 4253.91525161082, 4345.739255644671, 14724.631884202981, 14883.33025013877, 15380.692386152214, 15397.153156576496, 15404.075755454485, 14852.2573871306, 15080.698386032218, 15109.622259443382, 15124.016938899156, 15142.621434464227, 6948.861022779617, 8693.130686931383, 8729.214370706666, 8746.469367860598, 8749.343799215085, 5883.264591926009, 6131.509479241561, 7012.964935175291, 7034.859302813813, 7057.788266352018, 13215.537456188988, 13866.306684665928, 13889.861101388857, 13898.930505347409, 13907.0, 13851.0, 13932.442702291795, 13980.720385592027, 14099.718005639625, 14399.568012959628, 7945.682172713026, 9269.72190834276, 9544.85682714746, 9551.90448095538, 9584.185344245538, 10577.418241996456, 10618.256722029384, 10741.946290268812, 10761.192910531898, 10918.617848375268, 9126.908730912872, 9228.861567076365, 9252.814943701223, 9266.768330791785, 9277.814443710953, 8951.686690965786, 8979.191872731486, 9067.274618030673, 9204.401713888576, 9269.119433653792, 8006.519608823489, 8115.959420202861, 8229.300509456763, 8241.95879020601, 8254.587270636564, 6014.82128153485, 6051.425114614105, 6143.846403839761, 6181.041938499539, 6261.5616906816085, 5882.911756323744, 6105.389461053859, 6249.937500624936, 6251.812445626639, 6309.536206443408], "value": 5395.45454413034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.99845902963756, 398.3089339995109, 406.30116200135757, 408.0146446332108, 408.96728261739065, 5397.730113494319, 5823.475887170154, 6001.588832208324, 6061.909071363928, 6152.0, 5950.0, 5968.67172305523, 6031.401678555187, 6035.51715862731, 6065.2721673399255, 4443.777811109448, 4447.644188464931, 4463.68754187207, 4463.888402789924, 4486.842960496383, 4369.6285815705705, 4410.558944105596, 4453.421055262811, 4455.509893911667, 4455.598996090352, 3626.2928728897878, 4162.458880345551, 4373.497047839492, 4389.341598760196, 4411.713238639478, 3338.966610333914, 4335.82932608194, 4389.407429996957, 4401.493828209765, 4405.713628614146, 3702.685271751904, 3786.0345611869075, 3807.638274363931, 3810.1046254130256, 3821.159344944108, 5086.236185222909, 5944.316403613553, 5958.731857066442, 5973.549705469453, 5986.221791167164, 4512.345709872083, 5209.843704688866, 5218.791248350061, 5226.947730522684, 5253.949210157945, 5106.489351064901, 5322.7072511011875, 5625.887482250332, 5690.573207009449, 6015.578909476339, 4264.573542645741, 4273.551277115889, 4276.337167738974, 4279.379489973968, 4291.935620965688, 6593.736250549972, 6773.0, 6787.694553745093, 6832.829179270509, 6913.585184888922, 3596.6223546527763, 4250.553691862372, 4337.175936572041, 4345.9130817383475, 4349.434573505424, 3692.984429281969, 3730.7015438764834, 3836.3094642964534, 4400.515943246241, 4412.867613971586, 5175.663581867167, 5184.714840683723, 5224.320838290998, 5283.524482796567, 5526.198701188305, 5089.211172268304, 5982.49148822355, 6496.187976502937, 6584.473242140617, 6588.86822263552, 1557.6651020030747, 1696.202784691193, 1719.17479609788, 1727.5249306440578, 1742.7473016412803, 1207.4868181023205, 1208.7703336366062, 1213.5740504906698, 1214.40494157862, 1227.1593958138703, 6242.469390101892, 6242.719077641426, 6254.34329395416, 6261.686915654199, 6297.685115744286, 6427.58220715652, 6464.288928217892, 6499.6675681485185, 6656.96671516649, 6792.150981127359, 5441.782328706808, 6006.387221558636, 6192.411720886508, 6196.884560779013, 6197.287311959092, 3195.6418522128, 3423.400904841643, 3484.7038001770134, 3486.2330287336745, 3500.544929159244, 5769.826905192851, 6701.6314102723845, 6839.350261725128, 6910.581296546168, 6912.861742765217, 6616.768413105518, 6846.520743547904, 6851.109355783717, 6861.044602288324, 6862.897056544156, 6804.624346766098, 6860.931390686129, 6897.896531552031, 6923.792286231421, 6940.826479338057, 6323.873522529616, 6626.635535045619, 6627.906395444697, 6680.866382672417, 6682.2649508555, 4955.101265759571, 5640.830775076754, 6326.0, 6461.095446637569, 6550.279469258473, 5774.538036957118, 5990.682049949004, 6838.982500162563, 6870.381665650116, 6876.724931002704, 3672.412414013745, 4289.871303860889, 4299.204647140289, 4331.350297455407, 4345.739255644671, 6465.870682586228, 6580.901286480803, 6630.867382652416, 6636.203655561363, 6664.333566643297, 5609.242752228397, 6363.5545511813725, 6401.167848179707, 6421.454176394872, 6435.420812126931, 5300.761465734128, 6047.5464340173785, 6159.784407545714, 6460.0, 6512.437015116243, 5732.140178973187, 5790.363060063474, 6403.711832967434, 6420.325865784025, 6422.9081056221485, 5353.753321744634, 6339.0, 6482.57863238888, 6496.343432424702, 6541.901871471837, 6346.143270658402, 6383.6808159592765, 6393.177944285856, 6394.488440924808, 6410.5833120848865], "value": 4710.493625331529, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [845.8646616541355, 860.5009094725059, 869.3132425383947, 872.8603423452245, 881.5371929736889, 16342.83657163428, 16613.66772664546, 16727.916360418196, 16954.576135596617, 16959.067251301203, 15459.536213913572, 15634.29645665945, 15814.0, 15832.604184895383, 15843.445479408223, 958.9232861371091, 960.0063933828488, 960.6397600899662, 962.6005207838739, 963.0946909904667, 992.0476342711006, 997.0428388746811, 1005.3766664667916, 1006.2201793609975, 1009.5204777730593, 1027.7636143686957, 1042.3120740311397, 1051.1223128687554, 1052.3159946035062, 1053.0417320238585, 1044.634377967713, 1045.968620941373, 1046.3878631000873, 1046.70692206182, 1046.7958748044134, 776.6543887969856, 777.0131932445819, 778.5717855179629, 779.5244900610624, 784.000399490654, 14563.126212427289, 14973.550793476214, 14974.700505989818, 15169.0, 15259.389624415011, 13788.93105534476, 13926.234057126854, 14004.29978501071, 14219.85780142206, 14319.637259852112, 10725.410102444363, 12592.874071259263, 12616.81074783879, 12756.234625922474, 12770.616881493477, 3400.6769356911054, 3431.24512607226, 3437.432823584131, 3439.8624055037767, 3439.9828000860084, 75346.62326688386, 116127.0, 116213.41893290564, 116553.0, 116626.0, 11235.943820280847, 13707.451701931812, 13808.516701915385, 13835.169889806644, 13952.790708139386, 25108.0, 25149.11978080795, 26000.8699956499, 26586.069487567842, 26612.733872661414, 7612.162662107164, 7663.693452261959, 7835.882461763078, 7859.960700196577, 7863.0, 3788.0340513168967, 3888.572257051722, 3893.980530097388, 3902.414637804352, 3903.33643280643, 4235.53409124996, 4386.320120381346, 4460.776961151994, 4467.396901418332, 4467.7319360838455, 946.5929650250321, 951.752544338477, 959.0792838874619, 964.9228061755183, 967.7048500207363, 642.563057121162, 661.2461793555351, 664.2062735031687, 680.7481231944213, 697.7941507255372, 11138.49876755548, 11655.88344116548, 11877.287362758263, 12011.279323240633, 12157.0, 645.8805121052526, 647.970841312142, 652.3574279334852, 662.5163630549725, 685.3283781893672, 5151.531813433154, 5404.486913585123, 5497.367802702661, 5555.666580067554, 5635.830925072254, 100011.9994000297, 107493.46253268684, 108942.0, 109401.35897961537, 112218.70578412377, 72818.2718172822, 97904.51047744715, 98897.516537252, 99668.0, 100977.0, 61320.0, 68337.0, 84395.57802211073, 86552.56723716467, 86680.69978950321, 11748.882511175121, 12630.557930472389, 12814.231146131262, 13004.869951300745, 13059.608211753282, 32019.519707203945, 42380.57619423766, 42696.57303426926, 42983.71048868539, 43215.0, 65086.0, 65521.34478655343, 69304.0, 69841.65079174774, 69957.0, 16772.32910683559, 17182.828171718622, 17500.299988000337, 17523.649527009642, 17550.210240538952, 15589.59693627579, 18607.348742793936, 18659.81340186581, 18739.063046847332, 18786.0, 17226.224819882886, 17521.912390437967, 17751.73372399441, 17773.822261777736, 17887.463376098738, 16054.036757794569, 16305.755413669041, 17368.826311737226, 17497.82502174962, 17513.03678297655, 16113.919430402773, 16771.161441927612, 16816.243269052677, 17114.315427382764, 17281.913590431966, 9528.666496672584, 11012.39431831225, 11292.887071129184, 11584.362860042442, 12249.816252756038, 11602.0, 12405.255684658949, 13080.476780928657, 13120.803187951997, 13206.27365494907], "value": 8325.016969457578, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1428.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 109.0, 108.0, 109.0, 109.0, 108.0, 109.0, 109.0, 108.0, 110.0], "value": 108.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 109.0, 109.0, 142.0, 109.0, 107.0, 105.0, 99.0, 164.0, 143.0], "value": 122.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 181.0, 184.0, 184.0, 186.0, 183.0, 186.0, 184.0, 181.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 57.0, 88.0, 63.0, 56.0, 57.0, 57.0, 78.0, 57.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 85.0, 69.0, 69.0, 68.0, 87.0, 72.0, 98.0, 117.0], "value": 82.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 86.0, 88.0, 87.0, 88.0, 87.0, 87.0, 86.0, 88.0, 86.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 101.0, 93.0, 123.0, 151.0, 96.0, 94.0, 94.0, 94.0, 93.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 85.0, 86.0, 84.0, 83.0, 85.0, 86.0, 86.0, 83.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 49.0, 47.0, 46.0, 48.0, 50.0, 48.0, 47.0, 47.0, 48.0], "value": 47.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 60.0, 68.0, 61.0, 60.0, 56.0, 57.0, 57.0, 57.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 82.0, 81.0, 82.0, 80.0, 81.0, 88.0, 88.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 139.0, 147.0, 139.0, 135.0, 134.0, 136.0, 175.0, 155.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 181.0, 184.0, 184.0, 186.0, 183.0, 186.0, 185.0, 230.0, 178.0], "value": 188.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 66.0, 69.0, 68.0, 65.0, 68.0, 68.0, 68.0], "value": 67.5, "unit": "score"}]}]} 10:18:44 INFO - Return code: 0 10:18:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:44 INFO - # TBPL SUCCESS # 10:18:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:44 INFO - 2017-05-09 10:18:44.185 screenresolution[1651:9827] starting screenresolution argv=screenresolution get 10:18:44 INFO - 2017-05-09 10:18:44.189 screenresolution[1651:9827] Display 0: 1600x1200x32@60 10:18:44 INFO - 2017-05-09 10:18:44.195 screenresolution[1652:9830] starting screenresolution argv=screenresolution list 10:18:44 INFO - Available Modes on Display 0 10:18:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:44 INFO - Intel Iris: 10:18:44 INFO - Chipset Model: Intel Iris 10:18:44 INFO - Type: GPU 10:18:44 INFO - Bus: Built-In 10:18:44 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:44 INFO - Vendor: Intel (0x8086) 10:18:44 INFO - Device ID: 0x0a2e 10:18:44 INFO - Revision ID: 0x0009 10:18:44 INFO - Displays: 10:18:44 INFO - Display: 10:18:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:44 INFO - Display Serial Number: 1600x1200 60 10:18:44 INFO - Main Display: Yes 10:18:44 INFO - Mirror: Off 10:18:44 INFO - Online: Yes 10:18:44 INFO - Rotation: Supported 10:18:44 INFO - Return code: 0 10:18:44 INFO - Running post-action listener: _resource_record_post_action 10:18:44 INFO - [mozharness: 2017-05-09 17:18:44.440345Z] Finished run-tests step (success) 10:18:44 INFO - Running post-run listener: _resource_record_post_run 10:18:44 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 40031744; Write bytes: 527753216; Read time: 400; Write time: 1794 10:18:44 INFO - TinderboxPrint: CPU usage
53.3% 10:18:44 INFO - TinderboxPrint: I/O read bytes / time
40,031,744 / 400 10:18:44 INFO - TinderboxPrint: I/O write bytes / time
527,753,216 / 1,794 10:18:44 INFO - TinderboxPrint: CPU idle
2,238.7 (46.7%) 10:18:44 INFO - TinderboxPrint: CPU system
956.1 (19.9%) 10:18:44 INFO - TinderboxPrint: CPU user
1,598.9 (33.4%) 10:18:44 INFO - TinderboxPrint: Swap in / out
252,370,944 / 0 10:18:44 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 214260224; Write bytes: 216877056; Read time: 16811; Write time: 540 10:18:44 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 34829824; Write bytes: 309504000; Read time: 365; Write time: 1250 10:18:44 INFO - Running post-run listener: _upload_blobber_files 10:18:44 INFO - Blob upload gear active. 10:18:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:44 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 10:18:44 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'] 10:18:44 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 10:18:45 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:46 INFO - (blobuploader) - INFO - Done attempting. 10:18:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:47 INFO - (blobuploader) - INFO - Done attempting. 10:18:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:18:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:18:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:48 INFO - (blobuploader) - INFO - Done attempting. 10:18:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:50 INFO - (blobuploader) - INFO - Done attempting. 10:18:50 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:50 INFO - Return code: 0 10:18:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8263b5afc656fdeb29c5bba3185315ded45a6b48a5c495457f40664d7a08cf4a2e971ce6c25f8c9014641a7aaef799802b4d99e26fdf340aa5d6555609897117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a9514d83651e679a49b10ec46de1c0b15a1a65d43381b586b112261400a3098d5785e4bbdd1fbf21e5555a8b28b882e96b8c26d748d5ab69f95eb530137b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e11572350c80e7fdebf814e1fd163d6b9077d219f21d3240653492d8aed1d83b684c9354d7ca4c7001cc109ef0109a12b7e9fc0f84f091d07c31cf55976864ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c51460c26ac886742a39e02832fdb385ccbca5f9a901687383deeec47c40f61a915de86220878a0701369b29d2713f5f76f62b1d6e2eb5662b409e9b22c2cb"} 10:18:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:50 INFO - Contents: 10:18:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8263b5afc656fdeb29c5bba3185315ded45a6b48a5c495457f40664d7a08cf4a2e971ce6c25f8c9014641a7aaef799802b4d99e26fdf340aa5d6555609897117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a9514d83651e679a49b10ec46de1c0b15a1a65d43381b586b112261400a3098d5785e4bbdd1fbf21e5555a8b28b882e96b8c26d748d5ab69f95eb530137b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e11572350c80e7fdebf814e1fd163d6b9077d219f21d3240653492d8aed1d83b684c9354d7ca4c7001cc109ef0109a12b7e9fc0f84f091d07c31cf55976864ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c51460c26ac886742a39e02832fdb385ccbca5f9a901687383deeec47c40f61a915de86220878a0701369b29d2713f5f76f62b1d6e2eb5662b409e9b22c2cb"} 10:18:50 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:50 INFO - Copying logs to upload dir... 10:18:50 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.723559 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-05-09 10:18:50.256320) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 10:18:50.260337) ========= 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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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/8263b5afc656fdeb29c5bba3185315ded45a6b48a5c495457f40664d7a08cf4a2e971ce6c25f8c9014641a7aaef799802b4d99e26fdf340aa5d6555609897117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a9514d83651e679a49b10ec46de1c0b15a1a65d43381b586b112261400a3098d5785e4bbdd1fbf21e5555a8b28b882e96b8c26d748d5ab69f95eb530137b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e11572350c80e7fdebf814e1fd163d6b9077d219f21d3240653492d8aed1d83b684c9354d7ca4c7001cc109ef0109a12b7e9fc0f84f091d07c31cf55976864ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c51460c26ac886742a39e02832fdb385ccbca5f9a901687383deeec47c40f61a915de86220878a0701369b29d2713f5f76f62b1d6e2eb5662b409e9b22c2cb"} build_url:https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010869 build_url: 'https://queue.taskcluster.net/v1/task/Hd0MnQ4bTomi0Yc9PGoE9w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8263b5afc656fdeb29c5bba3185315ded45a6b48a5c495457f40664d7a08cf4a2e971ce6c25f8c9014641a7aaef799802b4d99e26fdf340aa5d6555609897117", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7a9514d83651e679a49b10ec46de1c0b15a1a65d43381b586b112261400a3098d5785e4bbdd1fbf21e5555a8b28b882e96b8c26d748d5ab69f95eb530137b8a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e11572350c80e7fdebf814e1fd163d6b9077d219f21d3240653492d8aed1d83b684c9354d7ca4c7001cc109ef0109a12b7e9fc0f84f091d07c31cf55976864ef", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/24c51460c26ac886742a39e02832fdb385ccbca5f9a901687383deeec47c40f61a915de86220878a0701369b29d2713f5f76f62b1d6e2eb5662b409e9b22c2cb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 10:18:50.292997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:18:50.293317) ========= 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.QWeXM8DcVL/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.Tv9PSwBOzZ/Listeners TMPDIR=/var/folders/l9/8sm1y5b96px5fvkn2jwjp59h00000w/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.005063 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 10:18:50.341866) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 10:18:50.342293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 10:18:50.342627) ========= ========= Total master_lag: 0.17 =========