builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0287 starttime: 1490283592.2 results: success (0) buildid: 20170323054323 builduid: 6356f05a5c0d461da9939481e909c3e1 revision: 89b93d310da5bc7f86ebcdb8fe580d47a610757a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.200859) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.201300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.201577) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.228031) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.228431) ========= 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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-03-23 08:39:52-- 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% 157M=0s 2017-03-23 08:39:52 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136020 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.388819) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.389129) ========= 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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.027159 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:52.437852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-23 08:39:52.438192) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 89b93d310da5bc7f86ebcdb8fe580d47a610757a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 89b93d310da5bc7f86ebcdb8fe580d47a610757a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-03-23 08:39:52,548 truncating revision to first 12 chars 2017-03-23 08:39:52,548 Setting DEBUG logging. 2017-03-23 08:39:52,548 attempt 1/10 2017-03-23 08:39:52,548 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/89b93d310da5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 08:39:53,714 unpacking tar archive at: mozilla-central-89b93d310da5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.435879 ========= master_lag: 1.98 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-03-23 08:39:55.856099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:55.856423) ========= script_repo_revision: 89b93d310da5bc7f86ebcdb8fe580d47a610757a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:55.856829) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:55.857185) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 08:39:55.878262) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-23 08:39:55.878649) ========= /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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:39:56 INFO - MultiFileLogger online at 20170323 08:39:56 in /builds/slave/test 08:39:56 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 08:39:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:39:56 INFO - {'append_to_log': False, 08:39:56 INFO - 'base_work_dir': '/builds/slave/test', 08:39:56 INFO - 'blob_upload_branch': 'Firefox', 08:39:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:39:56 INFO - 'branch': 'Firefox', 08:39:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:56 INFO - 'config_files': ('talos/mac_config.py',), 08:39:56 INFO - 'default_actions': ('clobber', 08:39:56 INFO - 'read-buildbot-config', 08:39:56 INFO - 'download-and-extract', 08:39:56 INFO - 'populate-webroot', 08:39:56 INFO - 'create-virtualenv', 08:39:56 INFO - 'install', 08:39:56 INFO - 'run-tests'), 08:39:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:56 INFO - 'download_minidump_stackwalk': True, 08:39:56 INFO - 'download_symbols': 'ondemand', 08:39:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:56 INFO - 'gecko_profile': False, 08:39:56 INFO - 'gecko_profile_interval': 0, 08:39:56 INFO - 'installer_path': 'installer.exe', 08:39:56 INFO - 'log_level': 'info', 08:39:56 INFO - 'log_name': 'talos', 08:39:56 INFO - 'log_to_console': True, 08:39:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:39:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:39:56 INFO - 'opt_config_files': (), 08:39:56 INFO - 'pip_index': False, 08:39:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:39:56 INFO - 'cmd': ('bash', 08:39:56 INFO - '-c', 08:39:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:39:56 INFO - 'enabled': True, 08:39:56 INFO - 'halt_on_failure': False, 08:39:56 INFO - 'name': 'check_screen_resolution'},), 08:39:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:39:56 INFO - 'cmd': ('bash', 08:39:56 INFO - '-c', 08:39:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:39:56 INFO - 'enabled': True, 08:39:56 INFO - 'halt_on_failure': False, 08:39:56 INFO - 'name': 'check_screen_resolution'},), 08:39:56 INFO - 'run_cmd_checks_enabled': True, 08:39:56 INFO - 'suite': 'dromaeojs', 08:39:56 INFO - 'system_bits': '32', 08:39:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:56 INFO - 'title': 't-yosemite-r7-0287', 08:39:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:56 INFO - 'use_talos_json': True, 08:39:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:39:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:56 INFO - 'work_dir': 'build'} 08:39:56 INFO - [mozharness: 2017-03-23 15:39:56.098053Z] Running clobber step. 08:39:56 INFO - Running pre-action listener: _resource_record_pre_action 08:39:56 INFO - Running main action method: clobber 08:39:56 INFO - rmtree: /builds/slave/test/build 08:39:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:39:58 INFO - Running post-action listener: _resource_record_post_action 08:39:58 INFO - [mozharness: 2017-03-23 15:39:58.645085Z] Finished clobber step (success) 08:39:58 INFO - [mozharness: 2017-03-23 15:39:58.645161Z] Running read-buildbot-config step. 08:39:58 INFO - Running pre-action listener: _resource_record_pre_action 08:39:58 INFO - Running main action method: read_buildbot_config 08:39:58 INFO - Using buildbot properties: 08:39:58 INFO - { 08:39:58 INFO - "project": "", 08:39:58 INFO - "product": "firefox", 08:39:58 INFO - "script_repo_revision": "production", 08:39:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:39:58 INFO - "repository": "", 08:39:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:39:58 INFO - "buildid": "20170323054323", 08:39:58 INFO - "pgo_build": "False", 08:39:58 INFO - "basedir": "/builds/slave/test", 08:39:58 INFO - "buildnumber": 86, 08:39:58 INFO - "slavename": "t-yosemite-r7-0287", 08:39:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:39:58 INFO - "platform": "yosemite_r7", 08:39:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:39:58 INFO - "branch": "mozilla-central", 08:39:58 INFO - "repo_path": "mozilla-central", 08:39:58 INFO - "revision": "89b93d310da5bc7f86ebcdb8fe580d47a610757a", 08:39:58 INFO - "stage_platform": "macosx64", 08:39:58 INFO - "builduid": "6356f05a5c0d461da9939481e909c3e1", 08:39:58 INFO - "slavebuilddir": "test" 08:39:58 INFO - } 08:39:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:39:58 INFO - Running post-action listener: _resource_record_post_action 08:39:58 INFO - [mozharness: 2017-03-23 15:39:58.648556Z] Finished read-buildbot-config step (success) 08:39:58 INFO - [mozharness: 2017-03-23 15:39:58.648703Z] Running download-and-extract step. 08:39:58 INFO - Running pre-action listener: _resource_record_pre_action 08:39:58 INFO - Running main action method: download_and_extract 08:39:58 INFO - mkdir: /builds/slave/test/build/tests 08:39:58 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')]} 08:39:58 INFO - trying https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:39:58 INFO - Downloading https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/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 08:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/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 08:39:59 INFO - Downloaded 1325 bytes. 08:39:59 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:39:59 INFO - Using the following test package requirements: 08:39:59 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 08:39:59 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:39:59 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:39:59 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:39:59 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'jsshell-mac.zip'], 08:39:59 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:39:59 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:39:59 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:39:59 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:39:59 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:39:59 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:39:59 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:39:59 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:39:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:39:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:39:59 INFO - Fetch https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:40:01 INFO - Expected file size: 52409469 08:40:01 INFO - Obtained file size: 52409469 08:40:17 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 08:40:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:40:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:40:17 INFO - Fetch https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:40:19 INFO - Expected file size: 52409469 08:40:19 INFO - Obtained file size: 52409469 08:40:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:40:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:40:34 INFO - Fetch https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:40:35 INFO - Expected file size: 14404171 08:40:35 INFO - Obtained file size: 14404171 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - trying https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:40:36 INFO - Downloading https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:40:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/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 08:40:38 INFO - Downloaded 75435752 bytes. 08:40:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:40:38 INFO - mkdir: /builds/slave/test/properties 08:40:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:38 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:38 INFO - Contents: 08:40:38 INFO - build_url:https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:40:39 INFO - Running post-action listener: _resource_record_post_action 08:40:39 INFO - Running post-action listener: set_extra_try_arguments 08:40:39 INFO - [mozharness: 2017-03-23 15:40:39.218698Z] Finished download-and-extract step (success) 08:40:39 INFO - [mozharness: 2017-03-23 15:40:39.218822Z] Running populate-webroot step. 08:40:39 INFO - Running pre-action listener: _resource_record_pre_action 08:40:39 INFO - Running main action method: populate_webroot 08:40:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:39 INFO - '--tppagecycles', 08:40:39 INFO - '7'], 08:40:39 INFO - 'tests': ['tsvgm']}}, 08:40:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['damp', 'tps']}, 08:40:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'tests': ['damp', 'tps']}, 08:40:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['dromaeo_dom']}, 08:40:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['basic_compositor_video']}, 08:40:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['a11yr', 08:40:39 INFO - 'ts_paint', 08:40:39 INFO - 'tpaint', 08:40:39 INFO - 'sessionrestore', 08:40:39 INFO - 'sessionrestore_no_auto_restore', 08:40:39 INFO - 'tabpaint']}, 08:40:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:39 INFO - 'ts_paint', 08:40:39 INFO - 'tpaint', 08:40:39 INFO - 'sessionrestore', 08:40:39 INFO - 'sessionrestore_no_auto_restore', 08:40:39 INFO - 'tabpaint']}, 08:40:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:39 INFO - 'ts_paint', 08:40:39 INFO - 'tpaint', 08:40:39 INFO - 'sessionrestore', 08:40:39 INFO - 'sessionrestore_no_auto_restore', 08:40:39 INFO - 'tabpaint']}, 08:40:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:39 INFO - 'ts_paint', 08:40:39 INFO - 'tpaint', 08:40:39 INFO - 'sessionrestore', 08:40:39 INFO - 'sessionrestore_no_auto_restore', 08:40:39 INFO - 'tabpaint']}, 08:40:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['a11yr', 08:40:39 INFO - 'ts_paint', 08:40:39 INFO - 'tpaint', 08:40:39 INFO - 'sessionrestore', 08:40:39 INFO - 'sessionrestore_no_auto_restore', 08:40:39 INFO - 'tabpaint']}, 08:40:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['a11yr', 08:40:39 INFO - 'ts_paint', 08:40:39 INFO - 'tpaint', 08:40:39 INFO - 'sessionrestore', 08:40:39 INFO - 'sessionrestore_no_auto_restore', 08:40:39 INFO - 'tabpaint']}, 08:40:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['tsvgx', 08:40:39 INFO - 'tsvgr_opacity', 08:40:39 INFO - 'tart', 08:40:39 INFO - 'tscrollx', 08:40:39 INFO - 'cart', 08:40:39 INFO - 'tsvg_static']}, 08:40:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:39 INFO - 'tsvgr_opacity', 08:40:39 INFO - 'tart', 08:40:39 INFO - 'tscrollx', 08:40:39 INFO - 'cart', 08:40:39 INFO - 'tsvg_static']}, 08:40:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'talos_options': ['--disable-e10s'], 08:40:39 INFO - 'tests': ['tp5o']}, 08:40:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:40:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'talos_options': ['--disable-e10s', 08:40:39 INFO - '--xperf_path', 08:40:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:39 INFO - 'tests': ['tp5n']}, 08:40:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:40:39 INFO - 'talos_options': ['--xperf_path', 08:40:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:39 INFO - 'tests': ['tp5n']}}, 08:40:39 INFO - 'talos.zip': {'path': '', 08:40:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:39 INFO - Running post-action listener: _resource_record_post_action 08:40:39 INFO - [mozharness: 2017-03-23 15:40:39.237384Z] Finished populate-webroot step (success) 08:40:39 INFO - [mozharness: 2017-03-23 15:40:39.237522Z] Running create-virtualenv step. 08:40:39 INFO - Running pre-action listener: _resource_record_pre_action 08:40:39 INFO - Running main action method: create_virtualenv 08:40:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:39 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 08:40:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:39 INFO - Using real prefix '/tools/python27' 08:40:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:42 INFO - Installing pip.................done. 08:40:42 INFO - Return code: 0 08:40:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:43 INFO - Reading from file tmpfile_stdout 08:40:43 INFO - Output received: 08:40:43 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) 08:40:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:43 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')]} 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 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')]} 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 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 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:40:43 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 08:40:43 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 08:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:43 INFO - 'HOME': '/Users/cltbld', 08:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:43 INFO - 'LOGNAME': 'cltbld', 08:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:43 INFO - 'MOZ_NO_REMOTE': '1', 08:40:43 INFO - 'NO_EM_RESTART': '1', 08:40:43 INFO - 'PAGER': '/bin/cat', 08:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:43 INFO - 'PWD': '/builds/slave/test', 08:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:43 INFO - 'SHELL': '/bin/bash', 08:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:40:43 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:43 INFO - 'USER': 'cltbld', 08:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:43 INFO - 'XPC_FLAGS': '0x0', 08:40:43 INFO - 'XPC_SERVICE_NAME': '0', 08:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:43 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 08:40:43 INFO - Cleaning up... 08:40:43 INFO - Return code: 0 08:40:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:43 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')]} 08:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 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')]} 08:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:43 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 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:40:43 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 08:40:43 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 08:40:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:40:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:43 INFO - 'HOME': '/Users/cltbld', 08:40:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:43 INFO - 'LOGNAME': 'cltbld', 08:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:43 INFO - 'MOZ_NO_REMOTE': '1', 08:40:43 INFO - 'NO_EM_RESTART': '1', 08:40:43 INFO - 'PAGER': '/bin/cat', 08:40:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:43 INFO - 'PWD': '/builds/slave/test', 08:40:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:43 INFO - 'SHELL': '/bin/bash', 08:40:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:40:43 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:40:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:43 INFO - 'USER': 'cltbld', 08:40:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:43 INFO - 'XPC_FLAGS': '0x0', 08:40:43 INFO - 'XPC_SERVICE_NAME': '0', 08:40:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:43 INFO - Downloading/unpacking psutil>=3.1.1 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 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 08:40:43 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 08:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:47 INFO - Installing collected packages: psutil 08:40:47 INFO - Running setup.py install for psutil 08:40:47 INFO - building 'psutil._psutil_osx' extension 08:40:47 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 08:40:47 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 08:40:47 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 08:40:48 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 08:40:48 INFO - building 'psutil._psutil_posix' extension 08:40:48 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 08:40:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:40:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:40:48 INFO - ^ 08:40:48 INFO - 1 warning generated. 08:40:48 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 08:40:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:48 INFO - Successfully installed psutil 08:40:48 INFO - Cleaning up... 08:40:48 INFO - Return code: 0 08:40:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:48 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')]} 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:48 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')]} 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:49 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 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:40:49 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 08:40:49 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 08:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:49 INFO - 'HOME': '/Users/cltbld', 08:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:49 INFO - 'LOGNAME': 'cltbld', 08:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:49 INFO - 'MOZ_NO_REMOTE': '1', 08:40:49 INFO - 'NO_EM_RESTART': '1', 08:40:49 INFO - 'PAGER': '/bin/cat', 08:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:49 INFO - 'PWD': '/builds/slave/test', 08:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:49 INFO - 'SHELL': '/bin/bash', 08:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:40:49 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:49 INFO - 'USER': 'cltbld', 08:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:49 INFO - 'XPC_FLAGS': '0x0', 08:40:49 INFO - 'XPC_SERVICE_NAME': '0', 08:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:49 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 08:40:49 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 08:40:49 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 08:40:49 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 08:40:49 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 08:40:49 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 08:40:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:52 INFO - Installing collected packages: mozsystemmonitor 08:40:52 INFO - Running setup.py install for mozsystemmonitor 08:40:52 INFO - Successfully installed mozsystemmonitor 08:40:52 INFO - Cleaning up... 08:40:52 INFO - Return code: 0 08:40:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:52 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 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:40:52 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 08:40:52 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 08:40:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:40:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:52 INFO - 'HOME': '/Users/cltbld', 08:40:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:52 INFO - 'LOGNAME': 'cltbld', 08:40:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:52 INFO - 'MOZ_NO_REMOTE': '1', 08:40:52 INFO - 'NO_EM_RESTART': '1', 08:40:52 INFO - 'PAGER': '/bin/cat', 08:40:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:52 INFO - 'PWD': '/builds/slave/test', 08:40:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:52 INFO - 'SHELL': '/bin/bash', 08:40:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:40:52 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:40:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:52 INFO - 'USER': 'cltbld', 08:40:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:52 INFO - 'XPC_FLAGS': '0x0', 08:40:52 INFO - 'XPC_SERVICE_NAME': '0', 08:40:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:52 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:52 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 08:40:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:55 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:56 INFO - warning: no files found matching '*.txt' 08:40:56 INFO - no previously-included directories found matching 'build' 08:40:56 INFO - no previously-included directories found matching 'dist' 08:40:56 INFO - no previously-included directories found matching '.git*' 08:40:56 INFO - Installing collected packages: jsonschema, functools32 08:40:56 INFO - Running setup.py install for functools32 08:40:56 INFO - warning: no files found matching '*.txt' 08:40:56 INFO - no previously-included directories found matching 'build' 08:40:56 INFO - no previously-included directories found matching 'dist' 08:40:56 INFO - no previously-included directories found matching '.git*' 08:40:56 INFO - Successfully installed jsonschema functools32 08:40:56 INFO - Cleaning up... 08:40:56 INFO - Return code: 0 08:40:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:40:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:40:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:56 INFO - 'HOME': '/Users/cltbld', 08:40:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:56 INFO - 'LOGNAME': 'cltbld', 08:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:56 INFO - 'MOZ_NO_REMOTE': '1', 08:40:56 INFO - 'NO_EM_RESTART': '1', 08:40:56 INFO - 'PAGER': '/bin/cat', 08:40:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:56 INFO - 'PWD': '/builds/slave/test', 08:40:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:56 INFO - 'SHELL': '/bin/bash', 08:40:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:40:56 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:40:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:56 INFO - 'USER': 'cltbld', 08:40:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:56 INFO - 'XPC_FLAGS': '0x0', 08:40:56 INFO - 'XPC_SERVICE_NAME': '0', 08:40:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:56 INFO - Cleaning up... 08:40:56 INFO - Return code: 0 08:40:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:40:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:40:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:40:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:40:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:40:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:40:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:40:56 INFO - 'HOME': '/Users/cltbld', 08:40:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:40:56 INFO - 'LOGNAME': 'cltbld', 08:40:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:56 INFO - 'MOZ_NO_REMOTE': '1', 08:40:56 INFO - 'NO_EM_RESTART': '1', 08:40:56 INFO - 'PAGER': '/bin/cat', 08:40:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:40:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:56 INFO - 'PWD': '/builds/slave/test', 08:40:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:40:56 INFO - 'SHELL': '/bin/bash', 08:40:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:40:56 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:40:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:40:56 INFO - 'USER': 'cltbld', 08:40:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:40:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:40:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:56 INFO - 'XPC_FLAGS': '0x0', 08:40:56 INFO - 'XPC_SERVICE_NAME': '0', 08:40:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:40:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:56 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:59 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:40:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:00 INFO - Downloading docopt-0.6.1.tar.gz 08:41:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:00 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:00 INFO - Running setup.py install for blobuploader 08:41:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:01 INFO - Running setup.py install for requests 08:41:01 INFO - Running setup.py install for docopt 08:41:01 INFO - Successfully installed blobuploader requests docopt 08:41:01 INFO - Cleaning up... 08:41:01 INFO - Return code: 0 08:41:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:01 INFO - 'HOME': '/Users/cltbld', 08:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:01 INFO - 'LOGNAME': 'cltbld', 08:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:01 INFO - 'MOZ_NO_REMOTE': '1', 08:41:01 INFO - 'NO_EM_RESTART': '1', 08:41:01 INFO - 'PAGER': '/bin/cat', 08:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:01 INFO - 'PWD': '/builds/slave/test', 08:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:01 INFO - 'SHELL': '/bin/bash', 08:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:41:01 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:01 INFO - 'USER': 'cltbld', 08:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:01 INFO - 'XPC_FLAGS': '0x0', 08:41:01 INFO - 'XPC_SERVICE_NAME': '0', 08:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-lPxZuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-cXosmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-lcxAE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-7ZwjPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-hoHQfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-137So_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-F0BGhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-i1sYgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-9QqWSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-SZVLq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-mpYLQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-d3S3gj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-P5AaGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-tMnjg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-krOxci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-vUL6C1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-4axoCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:03 INFO - Running setup.py install for manifestparser 08:41:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:03 INFO - Running setup.py install for mozcrash 08:41:04 INFO - Running setup.py install for mozdebug 08:41:04 INFO - Running setup.py install for mozdevice 08:41:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Running setup.py install for mozfile 08:41:04 INFO - Running setup.py install for mozhttpd 08:41:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Running setup.py install for mozinfo 08:41:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Running setup.py install for mozInstall 08:41:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:04 INFO - Running setup.py install for mozleak 08:41:05 INFO - Running setup.py install for mozlog 08:41:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:05 INFO - Running setup.py install for moznetwork 08:41:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:05 INFO - Running setup.py install for mozprocess 08:41:05 INFO - Running setup.py install for mozprofile 08:41:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:05 INFO - Running setup.py install for mozrunner 08:41:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:05 INFO - Running setup.py install for mozscreenshot 08:41:05 INFO - Running setup.py install for moztest 08:41:06 INFO - Running setup.py install for mozversion 08:41:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:06 INFO - Cleaning up... 08:41:06 INFO - Return code: 0 08:41:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:41:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:41:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:06 INFO - 'HOME': '/Users/cltbld', 08:41:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:06 INFO - 'LOGNAME': 'cltbld', 08:41:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:06 INFO - 'MOZ_NO_REMOTE': '1', 08:41:06 INFO - 'NO_EM_RESTART': '1', 08:41:06 INFO - 'PAGER': '/bin/cat', 08:41:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:06 INFO - 'PWD': '/builds/slave/test', 08:41:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:06 INFO - 'SHELL': '/bin/bash', 08:41:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:41:06 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:41:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:06 INFO - 'USER': 'cltbld', 08:41:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:06 INFO - 'XPC_FLAGS': '0x0', 08:41:06 INFO - 'XPC_SERVICE_NAME': '0', 08:41:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:06 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-jmWpLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:06 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-WyBKPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:06 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)) 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:06 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-qicgAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:06 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-2calBj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:41:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:06 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-sHSZqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:07 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)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-6tGptK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-k2rurg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-5nrUkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-1wBjXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-DwiiV5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:07 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)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-oq3PCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-GoPlim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:07 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)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-PzIKWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:07 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-HwNDRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:08 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)) 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:08 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-x5wIaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:08 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)) 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:08 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-fYSpzg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:08 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)) 08:41:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:08 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-dBj_3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:10 INFO - Downloading blessings-1.6.tar.gz 08:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:11 INFO - Installing collected packages: blessings 08:41:11 INFO - Running setup.py install for blessings 08:41:11 INFO - Successfully installed blessings 08:41:11 INFO - Cleaning up... 08:41:11 INFO - Return code: 0 08:41:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:11 INFO - Reading from file tmpfile_stdout 08:41:11 INFO - Current package versions: 08:41:11 INFO - blessings == 1.6 08:41:11 INFO - blobuploader == 1.2.4 08:41:11 INFO - docopt == 0.6.1 08:41:11 INFO - functools32 == 3.2.3-2 08:41:11 INFO - jsonschema == 2.5.1 08:41:11 INFO - manifestparser == 1.1 08:41:11 INFO - mozInstall == 1.12 08:41:11 INFO - mozcrash == 1.0 08:41:11 INFO - mozdebug == 0.1 08:41:11 INFO - mozdevice == 0.49 08:41:11 INFO - mozfile == 1.2 08:41:11 INFO - mozhttpd == 0.7 08:41:11 INFO - mozinfo == 0.9 08:41:11 INFO - mozleak == 0.1 08:41:11 INFO - mozlog == 3.4 08:41:11 INFO - moznetwork == 0.27 08:41:11 INFO - mozprocess == 0.25 08:41:11 INFO - mozprofile == 0.28 08:41:11 INFO - mozrunner == 6.13 08:41:11 INFO - mozscreenshot == 0.1 08:41:11 INFO - mozsystemmonitor == 0.3 08:41:11 INFO - moztest == 0.8 08:41:11 INFO - mozversion == 1.4 08:41:11 INFO - psutil == 3.1.1 08:41:11 INFO - requests == 1.2.3 08:41:11 INFO - wsgiref == 0.1.2 08:41:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:11 INFO - 'HOME': '/Users/cltbld', 08:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:11 INFO - 'LOGNAME': 'cltbld', 08:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:11 INFO - 'MOZ_NO_REMOTE': '1', 08:41:11 INFO - 'NO_EM_RESTART': '1', 08:41:11 INFO - 'PAGER': '/bin/cat', 08:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:11 INFO - 'PWD': '/builds/slave/test', 08:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:11 INFO - 'SHELL': '/bin/bash', 08:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:41:11 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:11 INFO - 'USER': 'cltbld', 08:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:11 INFO - 'XPC_FLAGS': '0x0', 08:41:11 INFO - 'XPC_SERVICE_NAME': '0', 08:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:11 INFO - Cleaning up... 08:41:11 INFO - Return code: 0 08:41:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085e3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1085e6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94884bd490>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, '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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 08:41:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:41:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:11 INFO - 'HOME': '/Users/cltbld', 08:41:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:11 INFO - 'LOGNAME': 'cltbld', 08:41:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:11 INFO - 'MOZ_NO_REMOTE': '1', 08:41:11 INFO - 'NO_EM_RESTART': '1', 08:41:11 INFO - 'PAGER': '/bin/cat', 08:41:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:11 INFO - 'PWD': '/builds/slave/test', 08:41:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:11 INFO - 'SHELL': '/bin/bash', 08:41:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:41:11 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:41:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:11 INFO - 'USER': 'cltbld', 08:41:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:11 INFO - 'XPC_FLAGS': '0x0', 08:41:11 INFO - 'XPC_SERVICE_NAME': '0', 08:41:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:12 INFO - Cleaning up... 08:41:12 INFO - Return code: 0 08:41:12 INFO - Running post-action listener: _resource_record_post_action 08:41:12 INFO - Running post-action listener: _start_resource_monitoring 08:41:12 INFO - Starting resource monitoring. 08:41:12 INFO - [mozharness: 2017-03-23 15:41:12.143405Z] Finished create-virtualenv step (success) 08:41:12 INFO - [mozharness: 2017-03-23 15:41:12.144336Z] Running install step. 08:41:12 INFO - Running pre-action listener: _resource_record_pre_action 08:41:12 INFO - Running main action method: install 08:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:12 INFO - Reading from file tmpfile_stdout 08:41:12 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:12 INFO - Reading from file tmpfile_stdout 08:41:12 INFO - Output received: 08:41:12 INFO - Usage: mozinstall [options] installer 08:41:12 INFO - Options: 08:41:12 INFO - -h, --help show this help message and exit 08:41:12 INFO - -d DEST, --destination=DEST 08:41:12 INFO - Directory to install application into. [default: 08:41:12 INFO - "/builds/slave/test"] 08:41:12 INFO - --app=APP Application being installed. [default: firefox] 08:41:12 INFO - mkdir: /builds/slave/test/build/application 08:41:12 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'] 08:41:12 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 08:41:32 INFO - Reading from file tmpfile_stdout 08:41:32 INFO - Output received: 08:41:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:41:32 INFO - Running post-action listener: _resource_record_post_action 08:41:32 INFO - [mozharness: 2017-03-23 15:41:32.992375Z] Finished install step (success) 08:41:32 INFO - [mozharness: 2017-03-23 15:41:32.992511Z] Running run-tests step. 08:41:32 INFO - Running pre-action listener: _resource_record_pre_action 08:41:32 INFO - Running main action method: run_tests 08:41:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:33 INFO - 2017-03-23 08:41:33.007 screenresolution[1629:7356] starting screenresolution argv=screenresolution get 08:41:33 INFO - 2017-03-23 08:41:33.009 screenresolution[1629:7356] Display 0: 1600x1200x32@60 08:41:33 INFO - 2017-03-23 08:41:33.015 screenresolution[1630:7359] starting screenresolution argv=screenresolution list 08:41:33 INFO - Available Modes on Display 0 08:41:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:33 INFO - Intel Iris: 08:41:33 INFO - Chipset Model: Intel Iris 08:41:33 INFO - Type: GPU 08:41:33 INFO - Bus: Built-In 08:41:33 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:33 INFO - Vendor: Intel (0x8086) 08:41:33 INFO - Device ID: 0x0a2e 08:41:33 INFO - Revision ID: 0x0009 08:41:33 INFO - Displays: 08:41:33 INFO - Display: 08:41:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:33 INFO - Display Serial Number: 1600x1200 60 08:41:33 INFO - Main Display: Yes 08:41:33 INFO - Mirror: Off 08:41:33 INFO - Online: Yes 08:41:33 INFO - Rotation: Supported 08:41:33 INFO - Return code: 0 08:41:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:33 INFO - Python 2.7.3 08:41:33 INFO - Return code: 0 08:41:33 INFO - grabbing minidump binary from tooltool 08:41:33 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')]} 08:41:33 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 0x1083c1d30>, '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 0x1082e8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1083b6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:33 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 08:41:33 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 08:41:33 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 08:41:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:33 INFO - Return code: 0 08:41:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:33 INFO - ENV: RUST_BACKTRACE is now 1 08:41:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:33 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/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--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 08:41:33 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/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0287 --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 08:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CJxxlIkQbk/Render', 08:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:33 INFO - 'HOME': '/Users/cltbld', 08:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:33 INFO - 'LOGNAME': 'cltbld', 08:41:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:33 INFO - 'MOZ_NO_REMOTE': '1', 08:41:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:33 INFO - 'NO_EM_RESTART': '1', 08:41:33 INFO - 'PAGER': '/bin/cat', 08:41:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:33 INFO - 'PWD': '/builds/slave/test', 08:41:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:33 INFO - 'RUST_BACKTRACE': '1', 08:41:33 INFO - 'SHELL': '/bin/bash', 08:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GgaJQbsTyJ/Listeners', 08:41:33 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 08:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:33 INFO - 'USER': 'cltbld', 08:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:33 INFO - 'XPC_FLAGS': '0x0', 08:41:33 INFO - 'XPC_SERVICE_NAME': '0', 08:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:33 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/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--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 08:41:33 INFO - mozversion application_buildid: 20170323054323 08:41:33 INFO - mozversion application_changeset: 89b93d310da5bc7f86ebcdb8fe580d47a610757a 08:41:33 INFO - mozversion application_display_name: Nightly 08:41:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:33 INFO - mozversion application_name: Firefox 08:41:33 INFO - mozversion application_remotingname: firefox 08:41:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:33 INFO - mozversion application_vendor: Mozilla 08:41:33 INFO - mozversion application_version: 55.0a1 08:41:33 INFO - mozversion platform_buildid: 20170323054323 08:41:33 INFO - mozversion platform_changeset: 89b93d310da5bc7f86ebcdb8fe580d47a610757a 08:41:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:33 INFO - mozversion platform_version: 55.0a1 08:41:33 INFO - using testdate: 1490283693 08:41:33 INFO - actual date: 1490283693 08:41:33 INFO - starting webserver on 'localhost:49249' 08:41:33 INFO - SUITE-START | Running 2 tests 08:41:33 INFO - TEST-START | dromaeo_css 08:41:33 INFO - operating with platform_type : mac_ 08:41:33 INFO - Initialising browser for dromaeo_css test... 08:41:33 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpJ5wleV/profile http://localhost:49249/getInfo.html) 08:41:36 INFO - PID 1640 | __metrics Screen width/height:1600/1200 08:41:36 INFO - PID 1640 | colorDepth:24 08:41:36 INFO - PID 1640 | Browser inner width/height: 1024/689 08:41:36 INFO - PID 1640 | __metrics 08:41:36 INFO - PID 1640 | 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" 08:41:36 INFO - PID 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:37 INFO - TEST-INFO | 1640: exit 0 08:41:37 INFO - Browser initialized. 08:41:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:37 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpJ5wleV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:49 INFO - PID 1642 | RSS: Main: 234631168 08:41:49 INFO - PID 1642 | 08:44:54 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 08:44:56 INFO - PID 1642 | RSS: Main: 413302784 08:44:56 INFO - PID 1642 | 08:46:39 INFO - PID 1642 | ************************* 08:46:39 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 08:46:39 INFO - PID 1642 | 08:46:39 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:46:39 INFO - PID 1642 | Full stack: 08:46:39 INFO - PID 1642 | ************************* 08:47:59 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 08:48:00 INFO - PID 1642 | RSS: Main: 364978176 08:48:00 INFO - PID 1642 | 08:51:02 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 08:51:03 INFO - PID 1642 | RSS: Main: 348352512 08:51:03 INFO - PID 1642 | 08:54:05 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 08:54:06 INFO - PID 1642 | RSS: Main: 331554816 08:54:06 INFO - PID 1642 | 08:57:09 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 08:57:10 INFO - PID 1642 | RSS: Main: 334794752 08:57:10 INFO - PID 1642 | 09:00:13 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 09:00:14 INFO - PID 1642 | RSS: Main: 549154816 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | __start_tp_report 09:00:14 INFO - PID 1642 | _x_x_mozilla_page_load 09:00:14 INFO - PID 1642 | _x_x_mozilla_page_load_details 09:00:14 INFO - PID 1642 | |i|pagename|runs| 09:00:14 INFO - PID 1642 | |0;dojo.html;3437.82810859457;3463.7229021678268;3467.0812234757796;3475.7393195510344;3522.3835828729966;5932.139839723238;6017.909731354022;6056.606320589159;6134.509239260859;6166.4450199482035;6036.909446358297;6074.726637301321;6094.350380525048;6099.309783606488;6132.1721567588365;5262.973685131588;5416.268803711508;5444.7822087116665;5463.644863083907;5500.614956953015;4991.226359914201;5514.558835293167;5575.581831362644;5577.358603760558;5643.633163844357;5304.230886521433;5402.864928376822;5408.378036525811;5433.022056029913;5517.724113794295;5453.291072160633;5453.836384908459;5486.561075113981;5523.226748255248;5531.751071201766;4754.500777418356;5172.353455818023;5356.598255130842;5398.082326004589;5495.560355171617;5935.584509084366;6046.667433291167;6135.5398345124295;6148.446639802394;6171.7531298748;6274.968625156891;6310.684465776692;6333.904991425133;6336.651484168369;6342.841428964267;6384.32964538726;6493.448056915168;6533.379328963741;6581.21025476941;6606.471482281406;6086.239220097488;6104.298005729398;6145.201123853915;6165.414285642857;6176.907346389808;6612.86774264512;6638.5684930479365;6645.700943457556;6647.66761661915;6655.23464801554;6214;6266.686665666698;6308.179936608211;6338.841528961812;6340.619562826245;6438.227412710411;6504.219493660791;6523.804285871432;6530.379613936763;6542;6423;6448.193975753031;6450.387213214737;6463.030545418131;6471.0940468334475;5034.572061374751;5035;6122.469312928377;6292.276388215322;6390.680465976682;5259.63182577216;5270.420253772082;5282.524572788468;5286.8942621148135;5316.680999140064;4655.068986202773;4662.860114196512;4681.040386720714;4691;4721.905561888743;5951.613145145551;6094.329623741385;6120.418560236771;6128.846778830565;6142.6314421134875;6381.680915954184;6504.902426463606;6543.9345606544275;6559.901601475982;6592.373724496165;6101.267847858197;6105.236845394325;6110.572259941761;6127.6936153193055;6129.478994285447;5812.622179558315;5888.046298144015;5892.234009578813;5897.439743224387;5970.641761494324;6264.906026409516;6386.393292637192;6475.676216189266;6475.902861457176;6622.403983641495;6060.666663333559;6296.150019747275;6604.537682362188;6615.272320044695;6630.867382652416;6448.193975753031;6467.514936379696;6612.437942774918;6623.105880706043;6641.33586641332;5804.448577385142;6088.817335479943;6465.967670161619;6474;6490.091387205889;6250.937490625218;6368.42684158428;6467.773627923;6605.867882642224;6607.108040414482;5384.7576859040655;6304;6347.460465860454;6362.045693146065;6374.776882809079;6340.239171299474;6341.587796793194;6349.333320001333;6357.586756860789;6359.427651511386;6215.06773983906;6263.561550691408;6279.3720627938665;6291.339409362135;6293.307736148929;6158.753649853956;6224.502039836892;6260.530460215593;6272;6280.309165991828;6161.045038019114;6170.784022559189;6178.1659475971965;6190.628562286277;6208.565400421927 09:00:14 INFO - PID 1642 | |1;ext.html;780.7189411811748;798.0981490915265;1127.915406344524;1144.8225525043622;1149.9885001149985;36305.818470907645;37214;37236.627633723685;37258.441123383105;37357.439638405376;38323;38818.80590597043;38827.61172388275;38843.504084632375;41099.178016439655;6058.757649694007;6203.549597908824;8511.616977236008;8691.478511289342;8697.913020869773;8303.750887473385;8475.872861907046;8483.363747718915;8511.659533618647;8517.23344898959;8536.44513106646;8578.656853725843;8604.741857744277;8605.827883442327;8610.095939926312;6040.154378387029;6197.380261973766;8490.53302068386;8565.35759818013;8567.057623661392;8147.388945829027;8290.46112002718;8295.917040829636;8302.377321700897;8307.335413166933;36792;37143.628563714556;37179.88460346194;37192.256154877025;37215.441768373494;2884.855757212131;2941.4705353036443;2960.156355438711;2970.006806472617;2981.195077329109;27537.862310688517;27572;27665.723342766516;27672.308192295153;27951.860240698665;2801.6638003439516;2803.9439211215663;2804.231750079704;2815.6198913146873;2842.459932612797;318160;320999;321010;321289;322321;37262.06844828847;37936.24127517489;38045.23909521794;48646;48800.53598392054;48362.75818620884;49061.754691227026;49065.773355666395;49142.26286605704;49168.770780730054;13769.173849569059;13893.722125557431;13907.860921390657;13911.095778774346;13913.930430347784;11407.973282404624;11451.656450306338;11696.181267311376;11711.707207319885;11745.647630571097;13030.08789384734;13031.566527681947;13044.608661740163;13085.476580936845;13214.225012747238;5307.681539107666;5327.440618735054;5339.733013349317;5344.331958505187;5348.518633322942;919.6367434863191;934.5887809363858;938.7230766923774;950.3727539823822;999.7400675824338;22392.776072239394;23523.647145292834;23748;23901.60983901596;24043.51912961731;954.8901876284316;986.6990567876867;1037.5538518436992;1059.1526778577108;1071.2340676416243;12016.939915300542;12091.395430228453;12123;12129.575464858688;12145.635630931087;394129;395215;395365;395490;395990;54397.72801135969;54470.72764636151;54478.45521544813;54489.91020179574;54584.454155457934;1394.072941493895;1459.6934643724937;1467.3983666696604;1468.2145052396916;1471.948481803153;22029.559408812056;23285;23672.408189794704;23778.978786803316;23790.514303827124;38080.23839523138;48781.756091219315;49599.760005998694;49616.503834961186;49634.75182624064;336081.31959340046;336528.6347136595;336716.31641841633;336996;383100;26333.736662633128;26666.466670666865;26805.86597067002;31650.68349316477;32860.83569582137;39753.602463976145;40200.798996004836;40888.79555602322;40973.59026409698;40993.79503102465;26338.86830565835;27139.23594966321;28070.43859122847;28880.566791497724;29228.707712922598;29144.27139321534;29560.260993475335;29600.202856901942;29749.958751443595;29776;35192;35283.294334113685;35466;35544.400501976954;35574.93275201748;28837.134885953456;29346.119616411543;29346.853265733534;29956.251093722833;31124;21728.23951161702;23776.930038148672;24046.15838445716;24450.51098977975;24454.388640283425 09:00:14 INFO - PID 1642 | |2;jquery.html;416.32289206900157;423.6250917937624;432.6646848692264;437.32433390411813;447.54797654369077;20374;21160.682589761127;21285.787142128574;21693;22212.555748885054;21806.563868722616;22614.66078008831;22734.43163920903;22738.31785046447;22965.885170574165;5905.143754155645;6031.72857221425;6336.239651241857;6343.429091381775;6345.936540634604;6140.692965351737;6238.095476155955;6242.563020588538;6277.372262773709;6282.434580887719;5893.145493903403;6154.5076393888385;6198.969005154968;6201.16284301618;6214.0368242922195;6074.665893375863;6106.419890110433;6135.815925522242;6198.450387403149;6199.597026193328;5443.074677304868;5510.366307874606;5533.916991245134;5540.556755459594;5541.251930989305;24507.56894034819;27833;27855.582166267523;27916;28217.717822821713;1860.4139695995852;1901.2204995951593;2004.5389560401043;2018.3541266794632;2042.346449136277;14021.64945876351;15762;16022.805856687206;16069.758953615705;16553.751693724604;1563.992180039104;1648.1264929587337;1659.7842280503457;1706.8122506524396;1740.034280974059;116702.49892503239;118747.406262969;140164.29917850345;144355;166817;11107.222494425474;12189.817152742717;12201.877981220252;12442.564510242279;12670.683232919251;16210;16215.918920405558;16229.2696828643;16275.674486510203;16305.124910635428;7702.306792388712;7736;8516.489010659381;8836.425632333878;9043.502607356659;8444.155584441629;8455.74632761018;8472.957635211907;8622;8631.568421578895;6632.839253130683;7524.586147761816;7657.770266892002;7660;7670.8082297943;1802.4142153800067;1840.8987505687048;2083.2604425428754;2083.4166433398673;2186.967195492069;851.8849955256085;903.6114470777497;911.5988964855575;916.862470629411;941.1623654947102;19222.327218547285;20592.382228533166;20779.064942077643;20812.791872081085;20855.791442085687;941.6186444489992;962.6582563190107;966.970990870275;970.4759429907912;981.5239608789731;10232.53953572091;10587.311824731369;10625.84061239082;10649.680509584725;10705;671197.6440117768;687438;701027;701254.6700497488;709747;151840;155231;156932;157671;161659;1106.336198281041;1137.761070175256;1165.4405885175163;1165.8717541070475;1167.7839599674087;17590.032548209972;17808.198631061892;17928.551786205448;17965.92204467736;18325.54186145357;61306.38693613007;61578;62132.99071634678;62393;62451;87317.56341218253;88046.31490535908;88794.11205887859;88795;90495.54752226197;6345.746170153327;7841.9021337014;8539.914600854161;8862;8931.642734290815;11428.885711143115;13771;14245.786313205517;14342.49801256951;14403.063800852911;11536.769264614828;11813.881861181279;12000.939995299968;12033;12039.398030098286;10960;11068.059214966817;11262.986331230228;11383.373914434786;11449;11543.955330476509;12032.639020829389;12131.272123672608;12150.75698486043;12267.386630668609;8581.871271931052;8590.398672092893;8751.91248087511;8928.419652722552;8997.955010224907;11686.532538698697;11751.882481175078;11961.940190298992;11985.580504682293;11988.880111199125 09:00:14 INFO - PID 1642 | |3;mootools.html;1161.2742036227357;1341;1407.2611878763648;1432.842387337392;1435.3038776193548;8929.464232146067;9381.484018378995;10199.133073688745;10474.895251047486;10484.895151048488;10233.539490722917;10455.215858810601;10475.476226188699;10484.58061677532;10537.473126343672;2366.325597204797;2399.3281881073326;2402.6396040593877;2408.385861605288;2411.0717373811035;1768.6285879965224;2127.606392817334;2331.4521087544413;2454.9263522094366;2457.7542245775367;2375.0974629640714;2416.6979127609047;2419.758024197584;2424.0425032112307;2425.854448733082;2064.4735592423986;2364.2788949370433;2417.057347634424;2427.271818454474;2428.3200703802963;2318.4783423729696;2373.7507561706116;2375.0499800079933;2385.0817435287368;2387.9880600596885;10451.11165550929;10578.682639520826;10583.84124238137;10602.310849794738;10607.469626518721;5249.291345668362;6026.367231440723;6261.96869015652;6268.968655156741;6269.310375858652;3694.1688120173017;3719.9070023249637;3927.8036098194975;3932.921341573181;3952.1107750756137;1157.69899826045;1179.0744067409712;1182.2669944634297;1205.5539450403319;1238.9194702344319;14173.645658858508;14412.351444185037;14558.199299038548;14593.343299551545;14622.195779232137;5255.211718242294;5456.372517160498;5567.888642227133;5592.3009623797025;5607.130894711327;12397.93801030989;12427.130100892851;12438.19151755133;12443.751124977449;12462.003039756979;6269.8746025079245;6272.153259309935;6275.309715931244;6284.465820405226;6287.371262873676;4706.388169537938;5421.918671219935;5524.889502209933;5591.7483713233005;5643;3869.28418242626;4030.355143177136;4368.191884501377;4413.8234470621455;4483.14820184164;1220.4915676029557;1316.9209847409186;1388.8194534710424;1391.6520869782555;1411.4918629293445;670.3196255800367;737.4985010193013;753.3859904178078;780.2704471319335;803.9799005024921;5579.972100139474;5698.373178950312;5860.8534786629825;5901.203337549462;6025.638461692225;865.7878819689216;895.9686410975715;905.4024343932973;908.2960705453195;909.3997961345481;2803;3514.964850351515;3549.2369140634887;3634.4548317752547;3634.9818250909107;12751.808722869164;13160.934195329153;13177.538786142632;13186.538471153655;13220;12106.213096148722;12660.177088489403;12693.048021398432;13018.088733788732;13147.211167329991;9470.95264523673;9723.562439690231;9730.36752611078;9739.513024348755;9747.976462471339;6176.413240742122;6471.7734879279;6675.299093595103;6687.565308254948;6692.364225398579;11705.707357315794;12082.879171208175;12102.213356131822;12223.144379893321;12231.021518278694;11766.88233117658;12107.455164517794;12121;12160.574379896661;12204.450799713857;8648.654053837776;8729;8811.867821982547;8841.513716745641;8845.159709827556;9674.935757066858;9691.806163876823;9760.85358719634;9790.608375664893;9795.559199835881;8096.392770542115;8243.381746369167;8301.543415111984;8317.293030092267;8423.536705481258;6718.664066796739;7968.282854543119;8121;8206.83586328282;8286.834263314578;6090.847728806815;7363.263673632594;7506.437017223621;7509.962450187714;7525.887111693439;5533.612647114664;5597.972010140086;5660.377358490645;5772.2207501986695;5778.451047150514;5653.434656534314;5784.421557844182;5859.949017843721;5909.953972940504;6000.87998240024 09:00:14 INFO - PID 1642 | |4;prototype.html;326.75819893278975;398.3785294939894;402.56724021676695;403.0427734131438;404.09079570965326;5909.468147866691;6016.759329626815;6031.849203769908;6053.757849686007;6113.2664080310315;5291.947080529194;5319.308489896318;5759.308882934043;5873.883962047208;5879.147523609085;3922.3724204127348;4034.1931613677234;4255.8084886180195;4604.700694454867;4618.79911223081;4629.259318509039;4641.675082744209;4655.231886738684;4662.440507139148;4674.088552732219;4469.977650111745;4563.885902852422;4578.153041687282;4614.377059097029;4636.814527418916;3555.839987200582;4556.476005259405;4563.794629241692;4570.79431425585;4582.312653102028;3497.4928635347987;3837.7910958048124;4034.072163402434;4051;4062.1111183299613;5564.387917329091;5737.913931291034;5753.539716822686;5809.970950145223;5846.76109820381;5397.136458166714;5411.485908838654;5426.348838139409;5436.439132368305;5443.1827832368635;5238.947610523884;6420.646864422455;6436.234802640461;6439.645819479927;6442.967785161044;4089.8364065437345;4257.8509752158525;4303.031817840992;4308.82764689412;4321.222180007598;5441.700706461143;5516.641418307797;6663.600183988976;6668.366505182;6687.598744075371;4242.7242229255;4374.650027997753;4375.934360984587;4382.474103107647;4384.934225986613;3698.2788356270808;4082.591740825894;4165.12532368206;4221;4416.911661766747;3963.920721585552;4285.849995250152;4830.913044564944;5166.121759300928;5220.843374698765;4738.573528382462;6359.268684101295;6420.357964203636;6440.323766004502;6442.452391546771;1488.4343949299198;1510.909345439277;1526.9847301526843;1527.3432424057762;1530.143119852886;983.7688143286322;1002.1031177096457;1003.0671475527829;1007.43080159711;1016.0956748493846;6026.638401695912;6042.6072305300895;6047.274327080779;6057.910021042733;6068.423499767603;6656.001599759978;6689;6707.384120193128;6716.563423377563;6732;5895.705214739246;5967.582269241198;5979.472111454263;6054.545909056838;6060.181875446847;3452.361313157074;3506.2111025019167;3506.2111025019167;3508.2808024354945;3529.770564913272;6215.762325562794;6383.042543618494;6624.006399040182;6800.353966373186;6848.315168483212;6313.1376244008125;6885.862282754417;6912.516123871281;6922.653867306715;6941.79174624752;5939.584229103922;6431.517636177306;6544.672766361663;6865.420953180696;6875.896861547081;6259.904516709648;6694.464442844658;6724.29394913527;6726.226483954408;6740.6966686498245;5925.4370834770625;6296.961001434712;6616.139901812733;6623.006549017493;6643;5846.064629659234;6459.289478157305;6739.59562426256;6831.661894696804;6841.897371539331;3988.641022308006;4115.0741083256025;4256.553061928453;4389.488409272505;4402.185595664812;5409.702466364388;5520.834374968757;6024.548158888013;6441.742330306735;6534.477241820738;5848.64908105515;6236.752649470215;6374.426301632875;6423.261324947691;6461.256955450183;6250.718717657807;6430.807075787734;6466.967665161644;6474.611523308617;6521.184851893513;5191.532762051434;6304.401081897213;6310.968445157929;6344.365563443619;6354.586951848115;6471.417572418505;6480.449161821298;6483.124778154889;6486.4486518646445;6537.477001839747;5379.596530260168;6043.637381757108;6281.7173227203975;6284.86872362979;6310.463610592968 09:00:14 INFO - PID 1642 | |5;yui.html;650.8893488107021;715.5170260074452;728.3699599846132;730.6310313291787;741.0588552538273;14165.71668566628;15701.371945122182;15739.134347610876;15743.13412762299;15843.603909902258;14912.552623421288;16003.919980400111;16510.42213522524;16684.83315166848;16686.998780073172;940.9576569054409;968.3173362779223;968.3463662028138;970.3110791338158;972.8540718892152;934.4580143516778;961.697065424389;966.84530475124;971.3880255439099;982.459647194044;1026.271347343387;1030.438411065967;1034.606849397228;1036.8807587127465;1038.3510306058713;1011.524583445783;1014.3862962907446;1017.3133135133829;1017.4607458047172;1026.2867307221484;753.408574269196;756.2664215710752;761.7105499910055;763.5418748750706;763.7555982085735;15410.614734631612;15627.296771645304;15899.205039747967;16285.755713664304;16519.6696066078;14205.928970355186;14444.783328250085;14542.054766440147;14610.634734131625;14641.926790366086;11590.884091159065;11610.593629223022;11799.646010619696;11880.643580692593;12138.575149869801;2915.4023425197784;3063.938721225563;3071.953920691169;3072.738817200541;3084.1826915867314;84394.57802711008;100244;104848;105930;108367.45816270947;10865.674029779118;11056.557737690402;11377.488013039432;11381.317120972768;11723.296602203895;23239.838008099527;24493.38766530851;24501.509969800503;24572.262832115066;24605.13882014121;7606.125295591078;7612.543247405173;7654.158042615308;7753.8449231015065;7877.133515313311;3932.901677458029;4156.085661154541;4196.51740049892;4226.2392769301205;4264.57354264571;4042.535108462506;4133.524644665842;4138.261929989411;4146.979265103655;4282.892927676833;809.1827254472907;836.3058661311219;849.8852654891634;857.9485230886166;869.0527325215419;536.9850981644695;549.6756913421101;560.3975726094384;563.9097744360882;577.1487056591494;9075.11984041131;9335.95661596533;9555.952220238854;10056.296059275926;10099.141572966233;538.163156291962;543.7444401131462;556.9554435645139;575.4303239792575;588.5909293041295;4531.22969095248;4570.794314255866;4638.594016223619;4654.159673939065;4691.83745425106;89391;95904.08191836125;98876;101114;102366.44083897813;62985.68507157435;64670;66229.34426639373;68515;72469.6376518114;63909.72180556456;64731.676341618935;66011.6797664044;66575;67271.3272867265;10173.796524069625;10594.623757974094;10606.575736970435;10681.732956676145;10715.35707857531;32388.83805580957;34411.65588344185;35459.64540354563;35732.82133589315;36466.63533364632;44999.550004499535;45431.09137817159;45793.85515362143;46229.306560400946;46341.53658463372;11000.834987475355;13008.903960180332;13128.671783205496;13206.009549284034;13405.66485837862;13948.372323245681;14104.012719109563;14285.357158927665;14581.052231604912;14771.409143634564;12737.363131843185;12802.598060393002;12943.288119153536;13011.674708132372;13364.866351336363;11043;13108.934455327662;13276.53532126371;13411.865881341062;13742;8042.597870106589;10283.485825708834;12203.14577979533;12732.23606583608;13248.735025299633;9057.818843623223;9210.447373157363;9211.585478653611;9220.815583688423;9492.905070949202;7161.820954476179;9975.900240997787;10626.468676565986;11055.668329950115;11084.113270938467 09:00:14 INFO - PID 1642 | __end_tp_report 09:00:14 INFO - PID 1642 | __start_cc_report 09:00:14 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2208 09:00:14 INFO - PID 1642 | __end_cc_report 09:00:14 INFO - PID 1642 | __startTimestamp1490284814234__endTimestamp 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | ------- Summary: start ------- 09:00:14 INFO - PID 1642 | Number of tests: 6 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:5979.08 Median:6170.78 stddev:660.81 (10.7%) stddev-sans-first:632.05 09:00:14 INFO - PID 1642 | Values: 3437.8 3463.7 3467.1 3475.7 3522.4 5932.1 6017.9 6056.6 6134.5 6166.4 6036.9 6074.7 6094.4 6099.3 6132.2 5263.0 5416.3 5444.8 5463.6 5500.6 4991.2 5514.6 5575.6 5577.4 5643.6 5304.2 5402.9 5408.4 5433.0 5517.7 5453.3 5453.8 5486.6 5523.2 5531.8 4754.5 5172.4 5356.6 5398.1 5495.6 5935.6 6046.7 6135.5 6148.4 6171.8 6275.0 6310.7 6333.9 6336.7 6342.8 6384.3 6493.4 6533.4 6581.2 6606.5 6086.2 6104.3 6145.2 6165.4 6176.9 6612.9 6638.6 6645.7 6647.7 6655.2 6214.0 6266.7 6308.2 6338.8 6340.6 6438.2 6504.2 6523.8 6530.4 6542.0 6423.0 6448.2 6450.4 6463.0 6471.1 5034.6 5035.0 6122.5 6292.3 6390.7 5259.6 5270.4 5282.5 5286.9 5316.7 4655.1 4662.9 4681.0 4691.0 4721.9 5951.6 6094.3 6120.4 6128.8 6142.6 6381.7 6504.9 6543.9 6559.9 6592.4 6101.3 6105.2 6110.6 6127.7 6129.5 5812.6 5888.0 5892.2 5897.4 5970.6 6264.9 6386.4 6475.7 6475.9 6622.4 6060.7 6296.2 6604.5 6615.3 6630.9 6448.2 6467.5 6612.4 6623.1 6641.3 5804.4 6088.8 6466.0 6474.0 6490.1 6250.9 6368.4 6467.8 6605.9 6607.1 5384.8 6304.0 6347.5 6362.0 6374.8 6340.2 6341.6 6349.3 6357.6 6359.4 6215.1 6263.6 6279.4 6291.3 6293.3 6158.8 6224.5 6260.5 6272.0 6280.3 6161.0 6170.8 6178.2 6190.6 6208.6 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:49025.77 Median:35237.65 stddev:93949.53 (266.6%) stddev-sans-first:94143.26 09:00:14 INFO - PID 1642 | Values: 780.7 798.1 1127.9 1144.8 1150.0 36305.8 37214.0 37236.6 37258.4 37357.4 38323.0 38818.8 38827.6 38843.5 41099.2 6058.8 6203.5 8511.6 8691.5 8697.9 8303.8 8475.9 8483.4 8511.7 8517.2 8536.4 8578.7 8604.7 8605.8 8610.1 6040.2 6197.4 8490.5 8565.4 8567.1 8147.4 8290.5 8295.9 8302.4 8307.3 36792.0 37143.6 37179.9 37192.3 37215.4 2884.9 2941.5 2960.2 2970.0 2981.2 27537.9 27572.0 27665.7 27672.3 27951.9 2801.7 2803.9 2804.2 2815.6 2842.5 318160.0 320999.0 321010.0 321289.0 322321.0 37262.1 37936.2 38045.2 48646.0 48800.5 48362.8 49061.8 49065.8 49142.3 49168.8 13769.2 13893.7 13907.9 13911.1 13913.9 11408.0 11451.7 11696.2 11711.7 11745.6 13030.1 13031.6 13044.6 13085.5 13214.2 5307.7 5327.4 5339.7 5344.3 5348.5 919.6 934.6 938.7 950.4 999.7 22392.8 23523.6 23748.0 23901.6 24043.5 954.9 986.7 1037.6 1059.2 1071.2 12016.9 12091.4 12123.0 12129.6 12145.6 394129.0 395215.0 395365.0 395490.0 395990.0 54397.7 54470.7 54478.5 54489.9 54584.5 1394.1 1459.7 1467.4 1468.2 1471.9 22029.6 23285.0 23672.4 23779.0 23790.5 38080.2 48781.8 49599.8 49616.5 49634.8 336081.3 336528.6 336716.3 336996.0 383100.0 26333.7 26666.5 26805.9 31650.7 32860.8 39753.6 40200.8 40888.8 40973.6 40993.8 26338.9 27139.2 28070.4 28880.6 29228.7 29144.3 29560.3 29600.2 29750.0 29776.0 35192.0 35283.3 35466.0 35544.4 35574.9 28837.1 29346.1 29346.9 29956.3 31124.0 21728.2 23776.9 24046.2 24450.5 24454.4 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:40114.82 Median:22413.61 stddev:116278.48 (518.8%) stddev-sans-first:116566.47 09:00:14 INFO - PID 1642 | Values: 416.3 423.6 432.7 437.3 447.5 20374.0 21160.7 21285.8 21693.0 22212.6 21806.6 22614.7 22734.4 22738.3 22965.9 5905.1 6031.7 6336.2 6343.4 6345.9 6140.7 6238.1 6242.6 6277.4 6282.4 5893.1 6154.5 6199.0 6201.2 6214.0 6074.7 6106.4 6135.8 6198.5 6199.6 5443.1 5510.4 5533.9 5540.6 5541.3 24507.6 27833.0 27855.6 27916.0 28217.7 1860.4 1901.2 2004.5 2018.4 2042.3 14021.6 15762.0 16022.8 16069.8 16553.8 1564.0 1648.1 1659.8 1706.8 1740.0 116702.5 118747.4 140164.3 144355.0 166817.0 11107.2 12189.8 12201.9 12442.6 12670.7 16210.0 16215.9 16229.3 16275.7 16305.1 7702.3 7736.0 8516.5 8836.4 9043.5 8444.2 8455.7 8473.0 8622.0 8631.6 6632.8 7524.6 7657.8 7660.0 7670.8 1802.4 1840.9 2083.3 2083.4 2187.0 851.9 903.6 911.6 916.9 941.2 19222.3 20592.4 20779.1 20812.8 20855.8 941.6 962.7 967.0 970.5 981.5 10232.5 10587.3 10625.8 10649.7 10705.0 671197.6 687438.0 701027.0 701254.7 709747.0 151840.0 155231.0 156932.0 157671.0 161659.0 1106.3 1137.8 1165.4 1165.9 1167.8 17590.0 17808.2 17928.6 17965.9 18325.5 61306.4 61578.0 62133.0 62393.0 62451.0 87317.6 88046.3 88794.1 88795.0 90495.5 6345.7 7841.9 8539.9 8862.0 8931.6 11428.9 13771.0 14245.8 14342.5 14403.1 11536.8 11813.9 12000.9 12033.0 12039.4 10960.0 11068.1 11263.0 11383.4 11449.0 11544.0 12032.6 12131.3 12150.8 12267.4 8581.9 8590.4 8751.9 8928.4 8998.0 11686.5 11751.9 11961.9 11985.6 11988.9 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:6531.28 Median:3898.54 stddev:4016.55 (103.0%) stddev-sans-first:4007.54 09:00:14 INFO - PID 1642 | Values: 1161.3 1341.0 1407.3 1432.8 1435.3 8929.5 9381.5 10199.1 10474.9 10484.9 10233.5 10455.2 10475.5 10484.6 10537.5 2366.3 2399.3 2402.6 2408.4 2411.1 1768.6 2127.6 2331.5 2454.9 2457.8 2375.1 2416.7 2419.8 2424.0 2425.9 2064.5 2364.3 2417.1 2427.3 2428.3 2318.5 2373.8 2375.0 2385.1 2388.0 10451.1 10578.7 10583.8 10602.3 10607.5 5249.3 6026.4 6262.0 6269.0 6269.3 3694.2 3719.9 3927.8 3932.9 3952.1 1157.7 1179.1 1182.3 1205.6 1238.9 14173.6 14412.4 14558.2 14593.3 14622.2 5255.2 5456.4 5567.9 5592.3 5607.1 12397.9 12427.1 12438.2 12443.8 12462.0 6269.9 6272.2 6275.3 6284.5 6287.4 4706.4 5421.9 5524.9 5591.7 5643.0 3869.3 4030.4 4368.2 4413.8 4483.1 1220.5 1316.9 1388.8 1391.7 1411.5 670.3 737.5 753.4 780.3 804.0 5580.0 5698.4 5860.9 5901.2 6025.6 865.8 896.0 905.4 908.3 909.4 2803.0 3515.0 3549.2 3634.5 3635.0 12751.8 13160.9 13177.5 13186.5 13220.0 12106.2 12660.2 12693.0 13018.1 13147.2 9471.0 9723.6 9730.4 9739.5 9748.0 6176.4 6471.8 6675.3 6687.6 6692.4 11705.7 12082.9 12102.2 12223.1 12231.0 11766.9 12107.5 12121.0 12160.6 12204.5 8648.7 8729.0 8811.9 8841.5 8845.2 9674.9 9691.8 9760.9 9790.6 9795.6 8096.4 8243.4 8301.5 8317.3 8423.5 6718.7 7968.3 8121.0 8206.8 8286.8 6090.8 7363.3 7506.4 7510.0 7525.9 5533.6 5598.0 5660.4 5772.2 5778.5 5653.4 5784.4 5859.9 5910.0 6000.9 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5185.81 Median:5847.71 stddev:1616.64 (27.6%) stddev-sans-first:1579.50 09:00:14 INFO - PID 1642 | Values: 326.8 398.4 402.6 403.0 404.1 5909.5 6016.8 6031.8 6053.8 6113.3 5291.9 5319.3 5759.3 5873.9 5879.1 3922.4 4034.2 4255.8 4604.7 4618.8 4629.3 4641.7 4655.2 4662.4 4674.1 4470.0 4563.9 4578.2 4614.4 4636.8 3555.8 4556.5 4563.8 4570.8 4582.3 3497.5 3837.8 4034.1 4051.0 4062.1 5564.4 5737.9 5753.5 5810.0 5846.8 5397.1 5411.5 5426.3 5436.4 5443.2 5238.9 6420.6 6436.2 6439.6 6443.0 4089.8 4257.9 4303.0 4308.8 4321.2 5441.7 5516.6 6663.6 6668.4 6687.6 4242.7 4374.7 4375.9 4382.5 4384.9 3698.3 4082.6 4165.1 4221.0 4416.9 3963.9 4285.8 4830.9 5166.1 5220.8 4738.6 6359.3 6420.4 6440.3 6442.5 1488.4 1510.9 1527.0 1527.3 1530.1 983.8 1002.1 1003.1 1007.4 1016.1 6026.6 6042.6 6047.3 6057.9 6068.4 6656.0 6689.0 6707.4 6716.6 6732.0 5895.7 5967.6 5979.5 6054.5 6060.2 3452.4 3506.2 3506.2 3508.3 3529.8 6215.8 6383.0 6624.0 6800.4 6848.3 6313.1 6885.9 6912.5 6922.7 6941.8 5939.6 6431.5 6544.7 6865.4 6875.9 6259.9 6694.5 6724.3 6726.2 6740.7 5925.4 6297.0 6616.1 6623.0 6643.0 5846.1 6459.3 6739.6 6831.7 6841.9 3988.6 4115.1 4256.6 4389.5 4402.2 5409.7 5520.8 6024.5 6441.7 6534.5 5848.6 6236.8 6374.4 6423.3 6461.3 6250.7 6430.8 6467.0 6474.6 6521.2 5191.5 6304.4 6311.0 6344.4 6354.6 6471.4 6480.4 6483.1 6486.4 6537.5 5379.6 6043.6 6281.7 6284.9 6310.5 09:00:14 INFO - PID 1642 | 09:00:14 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:18215.83 Median:33400.25 stddev:25413.89 (76.1%) stddev-sans-first:25450.95 09:00:14 INFO - PID 1642 | Values: 650.9 715.5 728.4 730.6 741.1 14165.7 15701.4 15739.1 15743.1 15843.6 14912.6 16003.9 16510.4 16684.8 16687.0 941.0 968.3 968.3 970.3 972.9 934.5 961.7 966.8 971.4 982.5 1026.3 1030.4 1034.6 1036.9 1038.4 1011.5 1014.4 1017.3 1017.5 1026.3 753.4 756.3 761.7 763.5 763.8 15410.6 15627.3 15899.2 16285.8 16519.7 14205.9 14444.8 14542.1 14610.6 14641.9 11590.9 11610.6 11799.6 11880.6 12138.6 2915.4 3063.9 3072.0 3072.7 3084.2 84394.6 100244.0 104848.0 105930.0 108367.5 10865.7 11056.6 11377.5 11381.3 11723.3 23239.8 24493.4 24501.5 24572.3 24605.1 7606.1 7612.5 7654.2 7753.8 7877.1 3932.9 4156.1 4196.5 4226.2 4264.6 4042.5 4133.5 4138.3 4147.0 4282.9 809.2 836.3 849.9 857.9 869.1 537.0 549.7 560.4 563.9 577.1 9075.1 9336.0 9556.0 10056.3 10099.1 538.2 543.7 557.0 575.4 588.6 4531.2 4570.8 4638.6 4654.2 4691.8 89391.0 95904.1 98876.0 101114.0 102366.4 62985.7 64670.0 66229.3 68515.0 72469.6 63909.7 64731.7 66011.7 66575.0 67271.3 10173.8 10594.6 10606.6 10681.7 10715.4 32388.8 34411.7 35459.6 35732.8 36466.6 44999.6 45431.1 45793.9 46229.3 46341.5 11000.8 13008.9 13128.7 13206.0 13405.7 13948.4 14104.0 14285.4 14581.1 14771.4 12737.4 12802.6 12943.3 13011.7 13364.9 11043.0 13108.9 13276.5 13411.9 13742.0 8042.6 10283.5 12203.1 12732.2 13248.7 9057.8 9210.4 9211.6 9220.8 9492.9 7161.8 9975.9 10626.5 11055.7 11084.1 09:00:14 INFO - PID 1642 | -------- Summary: end -------- 09:00:14 INFO - PID 1642 | 09:00:14 INFO - TEST-INFO | 1642: exit 0 09:00:14 INFO - TEST-OK | dromaeo_css | took 1121378ms 09:00:14 INFO - TEST-START | kraken 09:00:14 INFO - operating with platform_type : mac_ 09:00:14 INFO - Initialising browser for kraken test... 09:00:14 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpgq_B7w/profile http://localhost:49249/getInfo.html) 09:00:17 INFO - PID 1652 | __metrics Screen width/height:1600/1200 09:00:17 INFO - PID 1652 | colorDepth:24 09:00:17 INFO - PID 1652 | Browser inner width/height: 1024/689 09:00:17 INFO - PID 1652 | __metrics 09:00:17 INFO - PID 1652 | 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:00:17 INFO - PID 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:00:18 INFO - TEST-INFO | 1652: exit 0 09:00:18 INFO - Browser initialized. 09:00:18 INFO - Running cycle 1/1 for kraken test... 09:00:18 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpgq_B7w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:30 INFO - PID 1653 | RSS: Main: 234242048 09:00:30 INFO - PID 1653 | 09:00:33 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:34 INFO - PID 1653 | RSS: Main: 285069312 09:00:34 INFO - PID 1653 | 09:00:37 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 09:00:37 INFO - PID 1653 | RSS: Main: 287526912 09:00:37 INFO - PID 1653 | 09:00:41 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 09:00:41 INFO - PID 1653 | RSS: Main: 379916288 09:00:41 INFO - PID 1653 | 09:00:43 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 09:00:44 INFO - PID 1653 | RSS: Main: 280608768 09:00:44 INFO - PID 1653 | 09:00:46 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:00:46 INFO - PID 1653 | RSS: Main: 285089792 09:00:46 INFO - PID 1653 | 09:00:50 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 09:00:50 INFO - PID 1653 | RSS: Main: 324915200 09:00:50 INFO - PID 1653 | 09:00:53 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 09:00:54 INFO - PID 1653 | RSS: Main: 338358272 09:00:54 INFO - PID 1653 | 09:00:57 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 09:00:57 INFO - PID 1653 | RSS: Main: 343134208 09:00:57 INFO - PID 1653 | 09:00:59 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:00 INFO - PID 1653 | RSS: Main: 303083520 09:01:00 INFO - PID 1653 | 09:01:01 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:02 INFO - PID 1653 | RSS: Main: 305184768 09:01:02 INFO - PID 1653 | 09:01:04 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:05 INFO - PID 1653 | RSS: Main: 307703808 09:01:05 INFO - PID 1653 | 09:01:08 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:09 INFO - PID 1653 | RSS: Main: 326688768 09:01:09 INFO - PID 1653 | 09:01:12 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:12 INFO - PID 1653 | RSS: Main: 320737280 09:01:12 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 09:01:14 INFO - PID 1653 | RSS: Main: 381800448 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | __start_tp_report 09:01:14 INFO - PID 1653 | _x_x_mozilla_page_load 09:01:14 INFO - PID 1653 | _x_x_mozilla_page_load_details 09:01:14 INFO - PID 1653 | |i|pagename|runs| 09:01:14 INFO - PID 1653 | |0;ai-astar;113;111;111;112;112;113;115;160;165;113 09:01:14 INFO - PID 1653 | |1;audio-beat-detection;167;145;145;154;122;148;114;111;135;112 09:01:14 INFO - PID 1653 | |2;audio-dft;256;261;204;185;183;184;179;183;183;185 09:01:14 INFO - PID 1653 | |3;audio-fft;81;60;60;91;61;60;58;57;74;60 09:01:14 INFO - PID 1653 | |4;audio-oscillator;91;71;88;69;70;72;84;69;69;86 09:01:14 INFO - PID 1653 | |5;imaging-gaussian-blur;88;88;88;94;135;97;89;89;89;88 09:01:14 INFO - PID 1653 | |6;imaging-darkroom;95;95;95;102;95;94;95;95;129;139 09:01:14 INFO - PID 1653 | |7;imaging-desaturate;86;84;86;83;86;84;85;83;83;87 09:01:14 INFO - PID 1653 | |8;json-parse-financial;61;59;60;60;59;61;62;59;60;60 09:01:14 INFO - PID 1653 | |9;json-stringify-tinderbox;54;60;57;65;66;62;57;57;58;57 09:01:14 INFO - PID 1653 | |10;stanford-crypto-aes;84;84;83;83;84;83;82;81;84;82 09:01:14 INFO - PID 1653 | |11;stanford-crypto-ccm;140;142;131;139;140;152;154;124;183;178 09:01:14 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;187;183;189;186;179;181;186;188;221;229 09:01:14 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;68;68;68;69;67;70;68;66;68;67 09:01:14 INFO - PID 1653 | __end_tp_report 09:01:14 INFO - PID 1653 | __start_cc_report 09:01:14 INFO - PID 1653 | _x_x_mozilla_cycle_collect,2159 09:01:14 INFO - PID 1653 | __end_cc_report 09:01:14 INFO - PID 1653 | __startTimestamp1490284874923__endTimestamp 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | ------- Summary: start ------- 09:01:14 INFO - PID 1653 | Number of tests: 14 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:122.50 Median:113.00 stddev:21.15 (18.7%) stddev-sans-first:22.15 09:01:14 INFO - PID 1653 | Values: 113.0 111.0 111.0 112.0 112.0 113.0 115.0 160.0 165.0 113.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:145.00 stddev:19.63 (13.5%) stddev-sans-first:17.14 09:01:14 INFO - PID 1653 | Values: 167.0 145.0 145.0 154.0 122.0 148.0 114.0 111.0 135.0 112.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:200.30 Median:185.00 stddev:31.42 (17.0%) stddev-sans-first:26.07 09:01:14 INFO - PID 1653 | Values: 256.0 261.0 204.0 185.0 183.0 184.0 179.0 183.0 183.0 185.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:11.68 (19.3%) stddev-sans-first:11.09 09:01:14 INFO - PID 1653 | Values: 81.0 60.0 60.0 91.0 61.0 60.0 58.0 57.0 74.0 60.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:78.00 stddev:9.12 (11.7%) stddev-sans-first:8.12 09:01:14 INFO - PID 1653 | Values: 91.0 71.0 88.0 69.0 70.0 72.0 84.0 69.0 69.0 86.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:94.50 Median:89.00 stddev:14.55 (16.4%) stddev-sans-first:15.25 09:01:14 INFO - PID 1653 | Values: 88.0 88.0 88.0 94.0 135.0 97.0 89.0 89.0 89.0 88.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:103.40 Median:95.00 stddev:16.45 (17.3%) stddev-sans-first:17.17 09:01:14 INFO - PID 1653 | Values: 95.0 95.0 95.0 102.0 95.0 94.0 95.0 95.0 129.0 139.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.50 stddev:1.49 (1.7%) stddev-sans-first:1.51 09:01:14 INFO - PID 1653 | Values: 86.0 84.0 86.0 83.0 86.0 84.0 85.0 83.0 83.0 87.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:60.10 Median:60.00 stddev:0.99 (1.7%) stddev-sans-first:1.00 09:01:14 INFO - PID 1653 | Values: 61.0 59.0 60.0 60.0 59.0 61.0 62.0 59.0 60.0 60.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:3.89 (6.6%) stddev-sans-first:3.62 09:01:14 INFO - PID 1653 | Values: 54.0 60.0 57.0 65.0 66.0 62.0 57.0 57.0 58.0 57.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.50 stddev:1.05 (1.3%) stddev-sans-first:1.05 09:01:14 INFO - PID 1653 | Values: 84.0 84.0 83.0 83.0 84.0 83.0 82.0 81.0 84.0 82.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:148.30 Median:147.00 stddev:19.11 (13.0%) stddev-sans-first:20.03 09:01:14 INFO - PID 1653 | Values: 140.0 142.0 131.0 139.0 140.0 152.0 154.0 124.0 183.0 178.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.90 Median:187.50 stddev:17.30 (9.2%) stddev-sans-first:18.22 09:01:14 INFO - PID 1653 | Values: 187.0 183.0 189.0 186.0 179.0 181.0 186.0 188.0 221.0 229.0 09:01:14 INFO - PID 1653 | 09:01:14 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.10 (1.6%) stddev-sans-first:1.17 09:01:14 INFO - PID 1653 | Values: 68.0 68.0 68.0 69.0 67.0 70.0 68.0 66.0 68.0 67.0 09:01:14 INFO - PID 1653 | -------- Summary: end -------- 09:01:14 INFO - PID 1653 | 09:01:15 INFO - TEST-INFO | 1653: exit 0 09:01:15 INFO - TEST-OK | kraken | took 60865ms 09:01:15 INFO - SUITE-END | took 1182s 09:01:16 INFO - Completed test suite (00:19:42) 09:01:16 INFO - javascript benchmark 09:01:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7504.715258030027, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3437.82810859457, 3463.7229021678268, 3467.0812234757796, 3475.7393195510344, 3522.3835828729966, 5932.139839723238, 6017.909731354022, 6056.606320589159, 6134.509239260859, 6166.4450199482035, 6036.909446358297, 6074.726637301321, 6094.350380525048, 6099.309783606488, 6132.1721567588365, 5262.973685131588, 5416.268803711508, 5444.7822087116665, 5463.644863083907, 5500.614956953015, 4991.226359914201, 5514.558835293167, 5575.581831362644, 5577.358603760558, 5643.633163844357, 5304.230886521433, 5402.864928376822, 5408.378036525811, 5433.022056029913, 5517.724113794295, 5453.291072160633, 5453.836384908459, 5486.561075113981, 5523.226748255248, 5531.751071201766, 4754.500777418356, 5172.353455818023, 5356.598255130842, 5398.082326004589, 5495.560355171617, 5935.584509084366, 6046.667433291167, 6135.5398345124295, 6148.446639802394, 6171.7531298748, 6274.968625156891, 6310.684465776692, 6333.904991425133, 6336.651484168369, 6342.841428964267, 6384.32964538726, 6493.448056915168, 6533.379328963741, 6581.21025476941, 6606.471482281406, 6086.239220097488, 6104.298005729398, 6145.201123853915, 6165.414285642857, 6176.907346389808, 6612.86774264512, 6638.5684930479365, 6645.700943457556, 6647.66761661915, 6655.23464801554, 6214.0, 6266.686665666698, 6308.179936608211, 6338.841528961812, 6340.619562826245, 6438.227412710411, 6504.219493660791, 6523.804285871432, 6530.379613936763, 6542.0, 6423.0, 6448.193975753031, 6450.387213214737, 6463.030545418131, 6471.0940468334475, 5034.572061374751, 5035.0, 6122.469312928377, 6292.276388215322, 6390.680465976682, 5259.63182577216, 5270.420253772082, 5282.524572788468, 5286.8942621148135, 5316.680999140064, 4655.068986202773, 4662.860114196512, 4681.040386720714, 4691.0, 4721.905561888743, 5951.613145145551, 6094.329623741385, 6120.418560236771, 6128.846778830565, 6142.6314421134875, 6381.680915954184, 6504.902426463606, 6543.9345606544275, 6559.901601475982, 6592.373724496165, 6101.267847858197, 6105.236845394325, 6110.572259941761, 6127.6936153193055, 6129.478994285447, 5812.622179558315, 5888.046298144015, 5892.234009578813, 5897.439743224387, 5970.641761494324, 6264.906026409516, 6386.393292637192, 6475.676216189266, 6475.902861457176, 6622.403983641495, 6060.666663333559, 6296.150019747275, 6604.537682362188, 6615.272320044695, 6630.867382652416, 6448.193975753031, 6467.514936379696, 6612.437942774918, 6623.105880706043, 6641.33586641332, 5804.448577385142, 6088.817335479943, 6465.967670161619, 6474.0, 6490.091387205889, 6250.937490625218, 6368.42684158428, 6467.773627923, 6605.867882642224, 6607.108040414482, 5384.7576859040655, 6304.0, 6347.460465860454, 6362.045693146065, 6374.776882809079, 6340.239171299474, 6341.587796793194, 6349.333320001333, 6357.586756860789, 6359.427651511386, 6215.06773983906, 6263.561550691408, 6279.3720627938665, 6291.339409362135, 6293.307736148929, 6158.753649853956, 6224.502039836892, 6260.530460215593, 6272.0, 6280.309165991828, 6161.045038019114, 6170.784022559189, 6178.1659475971965, 6190.628562286277, 6208.565400421927], "value": 5937.834376242413, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.7189411811748, 798.0981490915265, 1127.915406344524, 1144.8225525043622, 1149.9885001149985, 36305.818470907645, 37214.0, 37236.627633723685, 37258.441123383105, 37357.439638405376, 38323.0, 38818.80590597043, 38827.61172388275, 38843.504084632375, 41099.178016439655, 6058.757649694007, 6203.549597908824, 8511.616977236008, 8691.478511289342, 8697.913020869773, 8303.750887473385, 8475.872861907046, 8483.363747718915, 8511.659533618647, 8517.23344898959, 8536.44513106646, 8578.656853725843, 8604.741857744277, 8605.827883442327, 8610.095939926312, 6040.154378387029, 6197.380261973766, 8490.53302068386, 8565.35759818013, 8567.057623661392, 8147.388945829027, 8290.46112002718, 8295.917040829636, 8302.377321700897, 8307.335413166933, 36792.0, 37143.628563714556, 37179.88460346194, 37192.256154877025, 37215.441768373494, 2884.855757212131, 2941.4705353036443, 2960.156355438711, 2970.006806472617, 2981.195077329109, 27537.862310688517, 27572.0, 27665.723342766516, 27672.308192295153, 27951.860240698665, 2801.6638003439516, 2803.9439211215663, 2804.231750079704, 2815.6198913146873, 2842.459932612797, 318160.0, 320999.0, 321010.0, 321289.0, 322321.0, 37262.06844828847, 37936.24127517489, 38045.23909521794, 48646.0, 48800.53598392054, 48362.75818620884, 49061.754691227026, 49065.773355666395, 49142.26286605704, 49168.770780730054, 13769.173849569059, 13893.722125557431, 13907.860921390657, 13911.095778774346, 13913.930430347784, 11407.973282404624, 11451.656450306338, 11696.181267311376, 11711.707207319885, 11745.647630571097, 13030.08789384734, 13031.566527681947, 13044.608661740163, 13085.476580936845, 13214.225012747238, 5307.681539107666, 5327.440618735054, 5339.733013349317, 5344.331958505187, 5348.518633322942, 919.6367434863191, 934.5887809363858, 938.7230766923774, 950.3727539823822, 999.7400675824338, 22392.776072239394, 23523.647145292834, 23748.0, 23901.60983901596, 24043.51912961731, 954.8901876284316, 986.6990567876867, 1037.5538518436992, 1059.1526778577108, 1071.2340676416243, 12016.939915300542, 12091.395430228453, 12123.0, 12129.575464858688, 12145.635630931087, 394129.0, 395215.0, 395365.0, 395490.0, 395990.0, 54397.72801135969, 54470.72764636151, 54478.45521544813, 54489.91020179574, 54584.454155457934, 1394.072941493895, 1459.6934643724937, 1467.3983666696604, 1468.2145052396916, 1471.948481803153, 22029.559408812056, 23285.0, 23672.408189794704, 23778.978786803316, 23790.514303827124, 38080.23839523138, 48781.756091219315, 49599.760005998694, 49616.503834961186, 49634.75182624064, 336081.31959340046, 336528.6347136595, 336716.31641841633, 336996.0, 383100.0, 26333.736662633128, 26666.466670666865, 26805.86597067002, 31650.68349316477, 32860.83569582137, 39753.602463976145, 40200.798996004836, 40888.79555602322, 40973.59026409698, 40993.79503102465, 26338.86830565835, 27139.23594966321, 28070.43859122847, 28880.566791497724, 29228.707712922598, 29144.27139321534, 29560.260993475335, 29600.202856901942, 29749.958751443595, 29776.0, 35192.0, 35283.294334113685, 35466.0, 35544.400501976954, 35574.93275201748, 28837.134885953456, 29346.119616411543, 29346.853265733534, 29956.251093722833, 31124.0, 21728.23951161702, 23776.930038148672, 24046.15838445716, 24450.51098977975, 24454.388640283425], "value": 17117.818666193085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.32289206900157, 423.6250917937624, 432.6646848692264, 437.32433390411813, 447.54797654369077, 20374.0, 21160.682589761127, 21285.787142128574, 21693.0, 22212.555748885054, 21806.563868722616, 22614.66078008831, 22734.43163920903, 22738.31785046447, 22965.885170574165, 5905.143754155645, 6031.72857221425, 6336.239651241857, 6343.429091381775, 6345.936540634604, 6140.692965351737, 6238.095476155955, 6242.563020588538, 6277.372262773709, 6282.434580887719, 5893.145493903403, 6154.5076393888385, 6198.969005154968, 6201.16284301618, 6214.0368242922195, 6074.665893375863, 6106.419890110433, 6135.815925522242, 6198.450387403149, 6199.597026193328, 5443.074677304868, 5510.366307874606, 5533.916991245134, 5540.556755459594, 5541.251930989305, 24507.56894034819, 27833.0, 27855.582166267523, 27916.0, 28217.717822821713, 1860.4139695995852, 1901.2204995951593, 2004.5389560401043, 2018.3541266794632, 2042.346449136277, 14021.64945876351, 15762.0, 16022.805856687206, 16069.758953615705, 16553.751693724604, 1563.992180039104, 1648.1264929587337, 1659.7842280503457, 1706.8122506524396, 1740.034280974059, 116702.49892503239, 118747.406262969, 140164.29917850345, 144355.0, 166817.0, 11107.222494425474, 12189.817152742717, 12201.877981220252, 12442.564510242279, 12670.683232919251, 16210.0, 16215.918920405558, 16229.2696828643, 16275.674486510203, 16305.124910635428, 7702.306792388712, 7736.0, 8516.489010659381, 8836.425632333878, 9043.502607356659, 8444.155584441629, 8455.74632761018, 8472.957635211907, 8622.0, 8631.568421578895, 6632.839253130683, 7524.586147761816, 7657.770266892002, 7660.0, 7670.8082297943, 1802.4142153800067, 1840.8987505687048, 2083.2604425428754, 2083.4166433398673, 2186.967195492069, 851.8849955256085, 903.6114470777497, 911.5988964855575, 916.862470629411, 941.1623654947102, 19222.327218547285, 20592.382228533166, 20779.064942077643, 20812.791872081085, 20855.791442085687, 941.6186444489992, 962.6582563190107, 966.970990870275, 970.4759429907912, 981.5239608789731, 10232.53953572091, 10587.311824731369, 10625.84061239082, 10649.680509584725, 10705.0, 671197.6440117768, 687438.0, 701027.0, 701254.6700497488, 709747.0, 151840.0, 155231.0, 156932.0, 157671.0, 161659.0, 1106.336198281041, 1137.761070175256, 1165.4405885175163, 1165.8717541070475, 1167.7839599674087, 17590.032548209972, 17808.198631061892, 17928.551786205448, 17965.92204467736, 18325.54186145357, 61306.38693613007, 61578.0, 62132.99071634678, 62393.0, 62451.0, 87317.56341218253, 88046.31490535908, 88794.11205887859, 88795.0, 90495.54752226197, 6345.746170153327, 7841.9021337014, 8539.914600854161, 8862.0, 8931.642734290815, 11428.885711143115, 13771.0, 14245.786313205517, 14342.49801256951, 14403.063800852911, 11536.769264614828, 11813.881861181279, 12000.939995299968, 12033.0, 12039.398030098286, 10960.0, 11068.059214966817, 11262.986331230228, 11383.373914434786, 11449.0, 11543.955330476509, 12032.639020829389, 12131.272123672608, 12150.75698486043, 12267.386630668609, 8581.871271931052, 8590.398672092893, 8751.91248087511, 8928.419652722552, 8997.955010224907, 11686.532538698697, 11751.882481175078, 11961.940190298992, 11985.580504682293, 11988.880111199125], "value": 10298.297979106783, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1161.2742036227357, 1341.0, 1407.2611878763648, 1432.842387337392, 1435.3038776193548, 8929.464232146067, 9381.484018378995, 10199.133073688745, 10474.895251047486, 10484.895151048488, 10233.539490722917, 10455.215858810601, 10475.476226188699, 10484.58061677532, 10537.473126343672, 2366.325597204797, 2399.3281881073326, 2402.6396040593877, 2408.385861605288, 2411.0717373811035, 1768.6285879965224, 2127.606392817334, 2331.4521087544413, 2454.9263522094366, 2457.7542245775367, 2375.0974629640714, 2416.6979127609047, 2419.758024197584, 2424.0425032112307, 2425.854448733082, 2064.4735592423986, 2364.2788949370433, 2417.057347634424, 2427.271818454474, 2428.3200703802963, 2318.4783423729696, 2373.7507561706116, 2375.0499800079933, 2385.0817435287368, 2387.9880600596885, 10451.11165550929, 10578.682639520826, 10583.84124238137, 10602.310849794738, 10607.469626518721, 5249.291345668362, 6026.367231440723, 6261.96869015652, 6268.968655156741, 6269.310375858652, 3694.1688120173017, 3719.9070023249637, 3927.8036098194975, 3932.921341573181, 3952.1107750756137, 1157.69899826045, 1179.0744067409712, 1182.2669944634297, 1205.5539450403319, 1238.9194702344319, 14173.645658858508, 14412.351444185037, 14558.199299038548, 14593.343299551545, 14622.195779232137, 5255.211718242294, 5456.372517160498, 5567.888642227133, 5592.3009623797025, 5607.130894711327, 12397.93801030989, 12427.130100892851, 12438.19151755133, 12443.751124977449, 12462.003039756979, 6269.8746025079245, 6272.153259309935, 6275.309715931244, 6284.465820405226, 6287.371262873676, 4706.388169537938, 5421.918671219935, 5524.889502209933, 5591.7483713233005, 5643.0, 3869.28418242626, 4030.355143177136, 4368.191884501377, 4413.8234470621455, 4483.14820184164, 1220.4915676029557, 1316.9209847409186, 1388.8194534710424, 1391.6520869782555, 1411.4918629293445, 670.3196255800367, 737.4985010193013, 753.3859904178078, 780.2704471319335, 803.9799005024921, 5579.972100139474, 5698.373178950312, 5860.8534786629825, 5901.203337549462, 6025.638461692225, 865.7878819689216, 895.9686410975715, 905.4024343932973, 908.2960705453195, 909.3997961345481, 2803.0, 3514.964850351515, 3549.2369140634887, 3634.4548317752547, 3634.9818250909107, 12751.808722869164, 13160.934195329153, 13177.538786142632, 13186.538471153655, 13220.0, 12106.213096148722, 12660.177088489403, 12693.048021398432, 13018.088733788732, 13147.211167329991, 9470.95264523673, 9723.562439690231, 9730.36752611078, 9739.513024348755, 9747.976462471339, 6176.413240742122, 6471.7734879279, 6675.299093595103, 6687.565308254948, 6692.364225398579, 11705.707357315794, 12082.879171208175, 12102.213356131822, 12223.144379893321, 12231.021518278694, 11766.88233117658, 12107.455164517794, 12121.0, 12160.574379896661, 12204.450799713857, 8648.654053837776, 8729.0, 8811.867821982547, 8841.513716745641, 8845.159709827556, 9674.935757066858, 9691.806163876823, 9760.85358719634, 9790.608375664893, 9795.559199835881, 8096.392770542115, 8243.381746369167, 8301.543415111984, 8317.293030092267, 8423.536705481258, 6718.664066796739, 7968.282854543119, 8121.0, 8206.83586328282, 8286.834263314578, 6090.847728806815, 7363.263673632594, 7506.437017223621, 7509.962450187714, 7525.887111693439, 5533.612647114664, 5597.972010140086, 5660.377358490645, 5772.2207501986695, 5778.451047150514, 5653.434656534314, 5784.421557844182, 5859.949017843721, 5909.953972940504, 6000.87998240024], "value": 5005.869863750323, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.75819893278975, 398.3785294939894, 402.56724021676695, 403.0427734131438, 404.09079570965326, 5909.468147866691, 6016.759329626815, 6031.849203769908, 6053.757849686007, 6113.2664080310315, 5291.947080529194, 5319.308489896318, 5759.308882934043, 5873.883962047208, 5879.147523609085, 3922.3724204127348, 4034.1931613677234, 4255.8084886180195, 4604.700694454867, 4618.79911223081, 4629.259318509039, 4641.675082744209, 4655.231886738684, 4662.440507139148, 4674.088552732219, 4469.977650111745, 4563.885902852422, 4578.153041687282, 4614.377059097029, 4636.814527418916, 3555.839987200582, 4556.476005259405, 4563.794629241692, 4570.79431425585, 4582.312653102028, 3497.4928635347987, 3837.7910958048124, 4034.072163402434, 4051.0, 4062.1111183299613, 5564.387917329091, 5737.913931291034, 5753.539716822686, 5809.970950145223, 5846.76109820381, 5397.136458166714, 5411.485908838654, 5426.348838139409, 5436.439132368305, 5443.1827832368635, 5238.947610523884, 6420.646864422455, 6436.234802640461, 6439.645819479927, 6442.967785161044, 4089.8364065437345, 4257.8509752158525, 4303.031817840992, 4308.82764689412, 4321.222180007598, 5441.700706461143, 5516.641418307797, 6663.600183988976, 6668.366505182, 6687.598744075371, 4242.7242229255, 4374.650027997753, 4375.934360984587, 4382.474103107647, 4384.934225986613, 3698.2788356270808, 4082.591740825894, 4165.12532368206, 4221.0, 4416.911661766747, 3963.920721585552, 4285.849995250152, 4830.913044564944, 5166.121759300928, 5220.843374698765, 4738.573528382462, 6359.268684101295, 6420.357964203636, 6440.323766004502, 6442.452391546771, 1488.4343949299198, 1510.909345439277, 1526.9847301526843, 1527.3432424057762, 1530.143119852886, 983.7688143286322, 1002.1031177096457, 1003.0671475527829, 1007.43080159711, 1016.0956748493846, 6026.638401695912, 6042.6072305300895, 6047.274327080779, 6057.910021042733, 6068.423499767603, 6656.001599759978, 6689.0, 6707.384120193128, 6716.563423377563, 6732.0, 5895.705214739246, 5967.582269241198, 5979.472111454263, 6054.545909056838, 6060.181875446847, 3452.361313157074, 3506.2111025019167, 3506.2111025019167, 3508.2808024354945, 3529.770564913272, 6215.762325562794, 6383.042543618494, 6624.006399040182, 6800.353966373186, 6848.315168483212, 6313.1376244008125, 6885.862282754417, 6912.516123871281, 6922.653867306715, 6941.79174624752, 5939.584229103922, 6431.517636177306, 6544.672766361663, 6865.420953180696, 6875.896861547081, 6259.904516709648, 6694.464442844658, 6724.29394913527, 6726.226483954408, 6740.6966686498245, 5925.4370834770625, 6296.961001434712, 6616.139901812733, 6623.006549017493, 6643.0, 5846.064629659234, 6459.289478157305, 6739.59562426256, 6831.661894696804, 6841.897371539331, 3988.641022308006, 4115.0741083256025, 4256.553061928453, 4389.488409272505, 4402.185595664812, 5409.702466364388, 5520.834374968757, 6024.548158888013, 6441.742330306735, 6534.477241820738, 5848.64908105515, 6236.752649470215, 6374.426301632875, 6423.261324947691, 6461.256955450183, 6250.718717657807, 6430.807075787734, 6466.967665161644, 6474.611523308617, 6521.184851893513, 5191.532762051434, 6304.401081897213, 6310.968445157929, 6344.365563443619, 6354.586951848115, 6471.417572418505, 6480.449161821298, 6483.124778154889, 6486.4486518646445, 6537.477001839747, 5379.596530260168, 6043.637381757108, 6281.7173227203975, 6284.86872362979, 6310.463610592968], "value": 4681.941470550288, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.8893488107021, 715.5170260074452, 728.3699599846132, 730.6310313291787, 741.0588552538273, 14165.71668566628, 15701.371945122182, 15739.134347610876, 15743.13412762299, 15843.603909902258, 14912.552623421288, 16003.919980400111, 16510.42213522524, 16684.83315166848, 16686.998780073172, 940.9576569054409, 968.3173362779223, 968.3463662028138, 970.3110791338158, 972.8540718892152, 934.4580143516778, 961.697065424389, 966.84530475124, 971.3880255439099, 982.459647194044, 1026.271347343387, 1030.438411065967, 1034.606849397228, 1036.8807587127465, 1038.3510306058713, 1011.524583445783, 1014.3862962907446, 1017.3133135133829, 1017.4607458047172, 1026.2867307221484, 753.408574269196, 756.2664215710752, 761.7105499910055, 763.5418748750706, 763.7555982085735, 15410.614734631612, 15627.296771645304, 15899.205039747967, 16285.755713664304, 16519.6696066078, 14205.928970355186, 14444.783328250085, 14542.054766440147, 14610.634734131625, 14641.926790366086, 11590.884091159065, 11610.593629223022, 11799.646010619696, 11880.643580692593, 12138.575149869801, 2915.4023425197784, 3063.938721225563, 3071.953920691169, 3072.738817200541, 3084.1826915867314, 84394.57802711008, 100244.0, 104848.0, 105930.0, 108367.45816270947, 10865.674029779118, 11056.557737690402, 11377.488013039432, 11381.317120972768, 11723.296602203895, 23239.838008099527, 24493.38766530851, 24501.509969800503, 24572.262832115066, 24605.13882014121, 7606.125295591078, 7612.543247405173, 7654.158042615308, 7753.8449231015065, 7877.133515313311, 3932.901677458029, 4156.085661154541, 4196.51740049892, 4226.2392769301205, 4264.57354264571, 4042.535108462506, 4133.524644665842, 4138.261929989411, 4146.979265103655, 4282.892927676833, 809.1827254472907, 836.3058661311219, 849.8852654891634, 857.9485230886166, 869.0527325215419, 536.9850981644695, 549.6756913421101, 560.3975726094384, 563.9097744360882, 577.1487056591494, 9075.11984041131, 9335.95661596533, 9555.952220238854, 10056.296059275926, 10099.141572966233, 538.163156291962, 543.7444401131462, 556.9554435645139, 575.4303239792575, 588.5909293041295, 4531.22969095248, 4570.794314255866, 4638.594016223619, 4654.159673939065, 4691.83745425106, 89391.0, 95904.08191836125, 98876.0, 101114.0, 102366.44083897813, 62985.68507157435, 64670.0, 66229.34426639373, 68515.0, 72469.6376518114, 63909.72180556456, 64731.676341618935, 66011.6797664044, 66575.0, 67271.3272867265, 10173.796524069625, 10594.623757974094, 10606.575736970435, 10681.732956676145, 10715.35707857531, 32388.83805580957, 34411.65588344185, 35459.64540354563, 35732.82133589315, 36466.63533364632, 44999.550004499535, 45431.09137817159, 45793.85515362143, 46229.306560400946, 46341.53658463372, 11000.834987475355, 13008.903960180332, 13128.671783205496, 13206.009549284034, 13405.66485837862, 13948.372323245681, 14104.012719109563, 14285.357158927665, 14581.052231604912, 14771.409143634564, 12737.363131843185, 12802.598060393002, 12943.288119153536, 13011.674708132372, 13364.866351336363, 11043.0, 13108.934455327662, 13276.53532126371, 13411.865881341062, 13742.0, 8042.597870106589, 10283.485825708834, 12203.14577979533, 12732.23606583608, 13248.735025299633, 9057.818843623223, 9210.447373157363, 9211.585478653611, 9220.815583688423, 9492.905070949202, 7161.820954476179, 9975.900240997787, 10626.468676565986, 11055.668329950115, 11084.113270938467], "value": 7281.572990932373, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1495.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 111.0, 112.0, 112.0, 113.0, 115.0, 160.0, 165.0, 113.0], "value": 122.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 145.0, 145.0, 154.0, 122.0, 148.0, 114.0, 111.0, 135.0, 112.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [256.0, 261.0, 204.0, 185.0, 183.0, 184.0, 179.0, 183.0, 183.0, 185.0], "value": 200.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 91.0, 61.0, 60.0, 58.0, 57.0, 74.0, 60.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 88.0, 69.0, 70.0, 72.0, 84.0, 69.0, 69.0, 86.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 94.0, 135.0, 97.0, 89.0, 89.0, 89.0, 88.0], "value": 94.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 102.0, 95.0, 94.0, 95.0, 95.0, 129.0, 139.0], "value": 103.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 83.0, 86.0, 84.0, 85.0, 83.0, 83.0, 87.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 60.0, 59.0, 61.0, 62.0, 59.0, 60.0, 60.0], "value": 60.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 57.0, 65.0, 66.0, 62.0, 57.0, 57.0, 58.0, 57.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 83.0, 84.0, 83.0, 82.0, 81.0, 84.0, 82.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 142.0, 131.0, 139.0, 140.0, 152.0, 154.0, 124.0, 183.0, 178.0], "value": 148.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 189.0, 186.0, 179.0, 181.0, 186.0, 188.0, 221.0, 229.0], "value": 192.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 69.0, 67.0, 70.0, 68.0, 66.0, 68.0, 67.0], "value": 67.9, "unit": "score"}]}]} 09:01:16 INFO - Return code: 0 09:01:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:16 ERROR - # TBPL SUCCESS # 09:01:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:16 INFO - 2017-03-23 09:01:16.247 screenresolution[1657:9782] starting screenresolution argv=screenresolution get 09:01:16 INFO - 2017-03-23 09:01:16.250 screenresolution[1657:9782] Display 0: 1600x1200x32@60 09:01:16 INFO - 2017-03-23 09:01:16.256 screenresolution[1658:9785] starting screenresolution argv=screenresolution list 09:01:16 INFO - Available Modes on Display 0 09:01:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:16 INFO - Intel Iris: 09:01:16 INFO - Chipset Model: Intel Iris 09:01:16 INFO - Type: GPU 09:01:16 INFO - Bus: Built-In 09:01:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:16 INFO - Vendor: Intel (0x8086) 09:01:16 INFO - Device ID: 0x0a2e 09:01:16 INFO - Revision ID: 0x0009 09:01:16 INFO - Displays: 09:01:16 INFO - Display: 09:01:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:16 INFO - Display Serial Number: 1600x1200 60 09:01:16 INFO - Main Display: Yes 09:01:16 INFO - Mirror: Off 09:01:16 INFO - Online: Yes 09:01:16 INFO - Rotation: Supported 09:01:16 INFO - Return code: 0 09:01:16 INFO - Running post-action listener: _resource_record_post_action 09:01:16 INFO - [mozharness: 2017-03-23 16:01:16.492153Z] Finished run-tests step (success) 09:01:16 INFO - Running post-run listener: _resource_record_post_run 09:01:16 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 38556672; Write bytes: 511613440; Read time: 256; Write time: 1551 09:01:16 INFO - TinderboxPrint: CPU usage
53.4% 09:01:16 INFO - TinderboxPrint: I/O read bytes / time
38,556,672 / 256 09:01:16 INFO - TinderboxPrint: I/O write bytes / time
511,613,440 / 1,551 09:01:16 INFO - TinderboxPrint: CPU idle
2,244.9 (46.6%) 09:01:16 INFO - TinderboxPrint: CPU system
960.4 (20.0%) 09:01:16 INFO - TinderboxPrint: CPU user
1,608.5 (33.4%) 09:01:16 INFO - TinderboxPrint: Swap in / out
248,946,688 / 0 09:01:16 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202932736; Write bytes: 204396544; Read time: 15807; Write time: 431 09:01:16 INFO - run-tests - Wall time: 1183s; CPU: 53.0%; Read bytes: 37544960; Write bytes: 297267712; Read time: 242; Write time: 1089 09:01:16 INFO - Running post-run listener: _upload_blobber_files 09:01:16 INFO - Blob upload gear active. 09:01:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:18 INFO - (blobuploader) - INFO - Done attempting. 09:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:19 INFO - (blobuploader) - INFO - Done attempting. 09:01:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:19 INFO - (blobuploader) - INFO - Done attempting. 09:01:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:22 INFO - (blobuploader) - INFO - Done attempting. 09:01:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:22 INFO - Return code: 0 09:01:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c93ebcb1526f18bc0db70fbe938a88223048b2dc6ec0636659e7058664f37d132026e62f24cdde1685a4ae3fe1d4a38228df25b734d3a17ff2a89148cebd2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c20fa57dabc860a582c5a4cdc2a73da9e7adf638b2773794f24ef1753ade96dba59bd686da3df6d49e3906570336d9162de50a6b5963ed47d75bf913a03d0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aea00782a87cdabc0f40e538c3939d68ffdb8a227ce1177ae9200115fabf9393541fea13cce7bac79238a1ea49fc61ee423e0363b8692b0a686ab924a4ea604", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbca8203b26af37000d7b569d1196a9c0c3008e08c8e9bb30e31dec9f5b1050fb1c66347fcd655aa9e5958a05011c17db750be55baf478f41603be7e8eceabc"} 09:01:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:22 INFO - Contents: 09:01:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c93ebcb1526f18bc0db70fbe938a88223048b2dc6ec0636659e7058664f37d132026e62f24cdde1685a4ae3fe1d4a38228df25b734d3a17ff2a89148cebd2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c20fa57dabc860a582c5a4cdc2a73da9e7adf638b2773794f24ef1753ade96dba59bd686da3df6d49e3906570336d9162de50a6b5963ed47d75bf913a03d0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aea00782a87cdabc0f40e538c3939d68ffdb8a227ce1177ae9200115fabf9393541fea13cce7bac79238a1ea49fc61ee423e0363b8692b0a686ab924a4ea604", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbca8203b26af37000d7b569d1196a9c0c3008e08c8e9bb30e31dec9f5b1050fb1c66347fcd655aa9e5958a05011c17db750be55baf478f41603be7e8eceabc"} 09:01:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:22 INFO - Copying logs to upload dir... 09:01:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.341819 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-23 09:01:22.266242) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 09:01:22.270097) ========= 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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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/2c93ebcb1526f18bc0db70fbe938a88223048b2dc6ec0636659e7058664f37d132026e62f24cdde1685a4ae3fe1d4a38228df25b734d3a17ff2a89148cebd2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c20fa57dabc860a582c5a4cdc2a73da9e7adf638b2773794f24ef1753ade96dba59bd686da3df6d49e3906570336d9162de50a6b5963ed47d75bf913a03d0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aea00782a87cdabc0f40e538c3939d68ffdb8a227ce1177ae9200115fabf9393541fea13cce7bac79238a1ea49fc61ee423e0363b8692b0a686ab924a4ea604", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbca8203b26af37000d7b569d1196a9c0c3008e08c8e9bb30e31dec9f5b1050fb1c66347fcd655aa9e5958a05011c17db750be55baf478f41603be7e8eceabc"} build_url:https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011006 build_url: 'https://queue.taskcluster.net/v1/task/E6B-pf5fSIuylLwKvvHlQQ/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/2c93ebcb1526f18bc0db70fbe938a88223048b2dc6ec0636659e7058664f37d132026e62f24cdde1685a4ae3fe1d4a38228df25b734d3a17ff2a89148cebd2ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c20fa57dabc860a582c5a4cdc2a73da9e7adf638b2773794f24ef1753ade96dba59bd686da3df6d49e3906570336d9162de50a6b5963ed47d75bf913a03d0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6aea00782a87cdabc0f40e538c3939d68ffdb8a227ce1177ae9200115fabf9393541fea13cce7bac79238a1ea49fc61ee423e0363b8692b0a686ab924a4ea604", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8dbca8203b26af37000d7b569d1196a9c0c3008e08c8e9bb30e31dec9f5b1050fb1c66347fcd655aa9e5958a05011c17db750be55baf478f41603be7e8eceabc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 09:01:22.303777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:01:22.304083) ========= 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.CJxxlIkQbk/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.GgaJQbsTyJ/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.004558 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 09:01:22.352373) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 09:01:22.352703) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 09:01:22.353013) ========= ========= Total master_lag: 2.14 =========