builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0191 starttime: 1485575844.28 results: success (0) buildid: 20170127184008 builduid: 8e5e31ed05764a0a941a5d5653f6a4c5 revision: 045d8fe30f546ab08466c9586ce298e6459c2069 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.280511) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.280966) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.281259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.307463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.307911) ========= 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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-01-27 19:57:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.8M=0.001s 2017-01-27 19:57:24 (20.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137218 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.469438) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.469756) ========= 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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.027580 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:24.519246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-27 19:57:24.519593) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 045d8fe30f546ab08466c9586ce298e6459c2069 --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 045d8fe30f546ab08466c9586ce298e6459c2069 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.SFCdEeUaJT/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.mgHjQGTTd6/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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-01-27 19:57:24,622 truncating revision to first 12 chars 2017-01-27 19:57:24,622 Setting DEBUG logging. 2017-01-27 19:57:24,622 attempt 1/10 2017-01-27 19:57:24,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/045d8fe30f54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-27 19:57:26,669 unpacking tar archive at: mozilla-central-045d8fe30f54/testing/mozharness/ program finished with exit code 0 elapsedTime=2.319877 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-27 19:57:26.864512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:26.865100) ========= script_repo_revision: 045d8fe30f546ab08466c9586ce298e6459c2069 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:26.865756) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:26.866242) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-27 19:57:26.887134) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-27 19:57:26.887686) ========= /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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:57:27 INFO - MultiFileLogger online at 20170127 19:57:27 in /builds/slave/test 19:57:27 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 19:57:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:57:27 INFO - {'append_to_log': False, 19:57:27 INFO - 'base_work_dir': '/builds/slave/test', 19:57:27 INFO - 'blob_upload_branch': 'Firefox', 19:57:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:57:27 INFO - 'branch': 'Firefox', 19:57:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:57:27 INFO - 'config_files': ('talos/mac_config.py',), 19:57:27 INFO - 'default_actions': ('clobber', 19:57:27 INFO - 'read-buildbot-config', 19:57:27 INFO - 'download-and-extract', 19:57:27 INFO - 'populate-webroot', 19:57:27 INFO - 'create-virtualenv', 19:57:27 INFO - 'install', 19:57:27 INFO - 'run-tests'), 19:57:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:57:27 INFO - 'download_minidump_stackwalk': True, 19:57:27 INFO - 'download_symbols': 'ondemand', 19:57:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:57:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:57:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:57:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:57:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:57:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:57:27 INFO - 'installer_path': 'installer.exe', 19:57:27 INFO - 'log_level': 'info', 19:57:27 INFO - 'log_name': 'talos', 19:57:27 INFO - 'log_to_console': True, 19:57:27 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:57:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:57:27 INFO - 'opt_config_files': (), 19:57:27 INFO - 'pip_index': False, 19:57:27 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:57:27 INFO - 'cmd': ('bash', 19:57:27 INFO - '-c', 19:57:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:57:27 INFO - 'enabled': True, 19:57:27 INFO - 'halt_on_failure': False, 19:57:27 INFO - 'name': 'check_screen_resolution'},), 19:57:27 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:57:27 INFO - 'cmd': ('bash', 19:57:27 INFO - '-c', 19:57:27 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:57:27 INFO - 'enabled': True, 19:57:27 INFO - 'halt_on_failure': False, 19:57:27 INFO - 'name': 'check_screen_resolution'},), 19:57:27 INFO - 'run_cmd_checks_enabled': True, 19:57:27 INFO - 'sps_profile': False, 19:57:27 INFO - 'sps_profile_interval': 0, 19:57:27 INFO - 'suite': 'dromaeojs', 19:57:27 INFO - 'system_bits': '32', 19:57:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:57:27 INFO - 'title': 't-yosemite-r7-0191', 19:57:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:57:27 INFO - 'use_talos_json': True, 19:57:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:57:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:57:27 INFO - 'work_dir': 'build'} 19:57:27 INFO - [mozharness: 2017-01-28 03:57:27.100087Z] Running clobber step. 19:57:27 INFO - Running pre-action listener: _resource_record_pre_action 19:57:27 INFO - Running main action method: clobber 19:57:27 INFO - rmtree: /builds/slave/test/build 19:57:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:57:29 INFO - Running post-action listener: _resource_record_post_action 19:57:29 INFO - [mozharness: 2017-01-28 03:57:29.648852Z] Finished clobber step (success) 19:57:29 INFO - [mozharness: 2017-01-28 03:57:29.648988Z] Running read-buildbot-config step. 19:57:29 INFO - Running pre-action listener: _resource_record_pre_action 19:57:29 INFO - Running main action method: read_buildbot_config 19:57:29 INFO - Using buildbot properties: 19:57:29 INFO - { 19:57:29 INFO - "project": "", 19:57:29 INFO - "product": "firefox", 19:57:29 INFO - "script_repo_revision": "production", 19:57:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 19:57:29 INFO - "repository": "", 19:57:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 19:57:29 INFO - "buildid": "20170127184008", 19:57:29 INFO - "pgo_build": "False", 19:57:29 INFO - "basedir": "/builds/slave/test", 19:57:29 INFO - "buildnumber": 76, 19:57:29 INFO - "slavename": "t-yosemite-r7-0191", 19:57:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 19:57:29 INFO - "platform": "yosemite_r7", 19:57:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:57:29 INFO - "branch": "mozilla-central", 19:57:29 INFO - "repo_path": "mozilla-central", 19:57:29 INFO - "revision": "045d8fe30f546ab08466c9586ce298e6459c2069", 19:57:29 INFO - "stage_platform": "macosx64", 19:57:29 INFO - "builduid": "8e5e31ed05764a0a941a5d5653f6a4c5", 19:57:29 INFO - "slavebuilddir": "test" 19:57:29 INFO - } 19:57:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 19:57:29 INFO - Running post-action listener: _resource_record_post_action 19:57:29 INFO - [mozharness: 2017-01-28 03:57:29.652311Z] Finished read-buildbot-config step (success) 19:57:29 INFO - [mozharness: 2017-01-28 03:57:29.652443Z] Running download-and-extract step. 19:57:29 INFO - Running pre-action listener: _resource_record_pre_action 19:57:29 INFO - Running main action method: download_and_extract 19:57:29 INFO - mkdir: /builds/slave/test/build/tests 19:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:29 INFO - trying https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 19:57:29 INFO - Downloading https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 19:57:30 INFO - Downloaded 1199 bytes. 19:57:30 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 19:57:30 INFO - Using the following test package requirements: 19:57:30 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:57:30 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 19:57:30 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 19:57:30 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'jsshell-mac.zip'], 19:57:30 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 19:57:30 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 19:57:30 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 19:57:30 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 19:57:30 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 19:57:30 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 19:57:30 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 19:57:30 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:57:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:57:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:57:30 INFO - Fetch https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:57:31 INFO - Expected file size: 16361071 19:57:31 INFO - Obtained file size: 16361071 19:57:37 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:57:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 19:57:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:57:37 INFO - Fetch https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 19:57:38 INFO - Expected file size: 16361071 19:57:38 INFO - Obtained file size: 16361071 19:57:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 19:57:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:57:45 INFO - Fetch https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 19:57:46 INFO - Expected file size: 14403454 19:57:46 INFO - Obtained file size: 14403454 19:57:46 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')]} 19:57:46 INFO - trying https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:57:46 INFO - Downloading https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 19:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 19:57:49 INFO - Downloaded 70134217 bytes. 19:57:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:57:49 INFO - mkdir: /builds/slave/test/properties 19:57:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:57:49 INFO - Writing to file /builds/slave/test/properties/build_url 19:57:49 INFO - Contents: 19:57:49 INFO - build_url:https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 19:57:49 INFO - Running post-action listener: _resource_record_post_action 19:57:49 INFO - Running post-action listener: set_extra_try_arguments 19:57:49 INFO - [mozharness: 2017-01-28 03:57:49.690102Z] Finished download-and-extract step (success) 19:57:49 INFO - [mozharness: 2017-01-28 03:57:49.690273Z] Running populate-webroot step. 19:57:49 INFO - Running pre-action listener: _resource_record_pre_action 19:57:49 INFO - Running main action method: populate_webroot 19:57:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:57:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:57:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:57:49 INFO - '--tppagecycles', 19:57:49 INFO - '7'], 19:57:49 INFO - 'tests': ['tsvgm']}}, 19:57:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:57:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:57:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:57:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:57:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:57:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['damp', 'tps']}, 19:57:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'tests': ['damp', 'tps']}, 19:57:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['dromaeo_dom']}, 19:57:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:57:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['basic_compositor_video']}, 19:57:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:57:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['a11yr', 19:57:49 INFO - 'ts_paint', 19:57:49 INFO - 'tpaint', 19:57:49 INFO - 'sessionrestore', 19:57:49 INFO - 'sessionrestore_no_auto_restore', 19:57:49 INFO - 'tabpaint']}, 19:57:49 INFO - 'other-e10s': {'tests': ['a11yr', 19:57:49 INFO - 'ts_paint', 19:57:49 INFO - 'tpaint', 19:57:49 INFO - 'sessionrestore', 19:57:49 INFO - 'sessionrestore_no_auto_restore', 19:57:49 INFO - 'tabpaint']}, 19:57:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:57:49 INFO - 'ts_paint', 19:57:49 INFO - 'tpaint', 19:57:49 INFO - 'sessionrestore', 19:57:49 INFO - 'sessionrestore_no_auto_restore', 19:57:49 INFO - 'tabpaint']}, 19:57:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:57:49 INFO - 'ts_paint', 19:57:49 INFO - 'tpaint', 19:57:49 INFO - 'sessionrestore', 19:57:49 INFO - 'sessionrestore_no_auto_restore', 19:57:49 INFO - 'tabpaint']}, 19:57:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['a11yr', 19:57:49 INFO - 'ts_paint', 19:57:49 INFO - 'tpaint', 19:57:49 INFO - 'sessionrestore', 19:57:49 INFO - 'sessionrestore_no_auto_restore', 19:57:49 INFO - 'tabpaint']}, 19:57:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['a11yr', 19:57:49 INFO - 'ts_paint', 19:57:49 INFO - 'tpaint', 19:57:49 INFO - 'sessionrestore', 19:57:49 INFO - 'sessionrestore_no_auto_restore', 19:57:49 INFO - 'tabpaint']}, 19:57:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['tsvgx', 19:57:49 INFO - 'tsvgr_opacity', 19:57:49 INFO - 'tart', 19:57:49 INFO - 'tscrollx', 19:57:49 INFO - 'cart', 19:57:49 INFO - 'tsvg_static']}, 19:57:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:57:49 INFO - 'tsvgr_opacity', 19:57:49 INFO - 'tart', 19:57:49 INFO - 'tscrollx', 19:57:49 INFO - 'cart', 19:57:49 INFO - 'tsvg_static']}, 19:57:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'talos_options': ['--disable-e10s'], 19:57:49 INFO - 'tests': ['tp5o']}, 19:57:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:57:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'talos_options': ['--disable-e10s', 19:57:49 INFO - '--xperf_path', 19:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:49 INFO - 'tests': ['tp5n']}, 19:57:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:57:49 INFO - 'talos_options': ['--xperf_path', 19:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:57:49 INFO - 'tests': ['tp5n']}}, 19:57:49 INFO - 'talos.zip': {'path': '', 19:57:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:57:49 INFO - Running post-action listener: _resource_record_post_action 19:57:49 INFO - [mozharness: 2017-01-28 03:57:49.709118Z] Finished populate-webroot step (success) 19:57:49 INFO - [mozharness: 2017-01-28 03:57:49.709208Z] Running create-virtualenv step. 19:57:49 INFO - Running pre-action listener: _resource_record_pre_action 19:57:49 INFO - Running main action method: create_virtualenv 19:57:49 INFO - Creating virtualenv /builds/slave/test/build/venv 19:57:49 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 19:57:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:57:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:57:49 INFO - Using real prefix '/tools/python27' 19:57:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:57:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:57:53 INFO - Installing pip.................done. 19:57:53 INFO - Return code: 0 19:57:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:57:53 INFO - Reading from file tmpfile_stdout 19:57:53 INFO - Output received: 19:57:53 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) 19:57:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:53 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:57:53 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 19:57:53 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 19:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:53 INFO - 'HOME': '/Users/cltbld', 19:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:53 INFO - 'LOGNAME': 'cltbld', 19:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:53 INFO - 'MOZ_NO_REMOTE': '1', 19:57:53 INFO - 'NO_EM_RESTART': '1', 19:57:53 INFO - 'PAGER': '/bin/cat', 19:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:53 INFO - 'PWD': '/builds/slave/test', 19:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:53 INFO - 'SHELL': '/bin/bash', 19:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:57:53 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:53 INFO - 'USER': 'cltbld', 19:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:53 INFO - 'XPC_FLAGS': '0x0', 19:57:53 INFO - 'XPC_SERVICE_NAME': '0', 19:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:53 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 19:57:53 INFO - Cleaning up... 19:57:53 INFO - Return code: 0 19:57:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:53 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:57:53 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 19:57:53 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 19:57:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:57:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:53 INFO - 'HOME': '/Users/cltbld', 19:57:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:53 INFO - 'LOGNAME': 'cltbld', 19:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:53 INFO - 'MOZ_NO_REMOTE': '1', 19:57:53 INFO - 'NO_EM_RESTART': '1', 19:57:53 INFO - 'PAGER': '/bin/cat', 19:57:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:53 INFO - 'PWD': '/builds/slave/test', 19:57:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:53 INFO - 'SHELL': '/bin/bash', 19:57:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:57:53 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:57:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:53 INFO - 'USER': 'cltbld', 19:57:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:53 INFO - 'XPC_FLAGS': '0x0', 19:57:53 INFO - 'XPC_SERVICE_NAME': '0', 19:57:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:54 INFO - Downloading/unpacking psutil>=3.1.1 19:57:54 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 19:57:54 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 19:57:54 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 19:57:54 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 19:57:54 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 19:57:54 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 19:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:57:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:57 INFO - Installing collected packages: psutil 19:57:57 INFO - Running setup.py install for psutil 19:57:57 INFO - building 'psutil._psutil_osx' extension 19:57:57 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 19:57:58 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 19:57:58 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 19:57:58 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 19:57:58 INFO - building 'psutil._psutil_posix' extension 19:57:58 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 19:57:58 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:57:58 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:57:58 INFO - ^ 19:57:58 INFO - 1 warning generated. 19:57:58 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 19:57:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:57:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:57:58 INFO - Successfully installed psutil 19:57:58 INFO - Cleaning up... 19:57:58 INFO - Return code: 0 19:57:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:57: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')]} 19:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57: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')]} 19:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:57:58 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:57:58 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 19:57:58 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 19:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:57:58 INFO - 'HOME': '/Users/cltbld', 19:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:57:58 INFO - 'LOGNAME': 'cltbld', 19:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:57:58 INFO - 'MOZ_NO_REMOTE': '1', 19:57:58 INFO - 'NO_EM_RESTART': '1', 19:57:58 INFO - 'PAGER': '/bin/cat', 19:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:57:58 INFO - 'PWD': '/builds/slave/test', 19:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:57:58 INFO - 'SHELL': '/bin/bash', 19:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:57:58 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:57:58 INFO - 'USER': 'cltbld', 19:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:57:58 INFO - 'XPC_FLAGS': '0x0', 19:57:58 INFO - 'XPC_SERVICE_NAME': '0', 19:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:57:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:57: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 19:58:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:58:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:58:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:58:02 INFO - Installing collected packages: mozsystemmonitor 19:58:02 INFO - Running setup.py install for mozsystemmonitor 19:58:02 INFO - Successfully installed mozsystemmonitor 19:58:02 INFO - Cleaning up... 19:58:02 INFO - Return code: 0 19:58:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:02 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:02 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 19:58:02 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 19:58:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:02 INFO - 'HOME': '/Users/cltbld', 19:58:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:02 INFO - 'LOGNAME': 'cltbld', 19:58:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:02 INFO - 'MOZ_NO_REMOTE': '1', 19:58:02 INFO - 'NO_EM_RESTART': '1', 19:58:02 INFO - 'PAGER': '/bin/cat', 19:58:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:02 INFO - 'PWD': '/builds/slave/test', 19:58:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:02 INFO - 'SHELL': '/bin/bash', 19:58:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:02 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:02 INFO - 'USER': 'cltbld', 19:58:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:02 INFO - 'XPC_FLAGS': '0x0', 19:58:02 INFO - 'XPC_SERVICE_NAME': '0', 19:58:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:02 INFO - Downloading/unpacking jsonschema==2.5.1 19:58:02 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 19:58:02 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 19:58:02 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 19:58:02 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 19:58:02 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 19:58:02 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 19:58:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:58:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:58:05 INFO - Downloading functools32-3.2.3-2.tar.gz 19:58:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:58:05 INFO - warning: no files found matching '*.txt' 19:58:05 INFO - no previously-included directories found matching 'build' 19:58:05 INFO - no previously-included directories found matching 'dist' 19:58:05 INFO - no previously-included directories found matching '.git*' 19:58:05 INFO - Installing collected packages: jsonschema, functools32 19:58:05 INFO - Running setup.py install for functools32 19:58:05 INFO - warning: no files found matching '*.txt' 19:58:05 INFO - no previously-included directories found matching 'build' 19:58:05 INFO - no previously-included directories found matching 'dist' 19:58:05 INFO - no previously-included directories found matching '.git*' 19:58:05 INFO - Successfully installed jsonschema functools32 19:58:05 INFO - Cleaning up... 19:58:05 INFO - Return code: 0 19:58:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:58:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:05 INFO - 'HOME': '/Users/cltbld', 19:58:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:05 INFO - 'LOGNAME': 'cltbld', 19:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:05 INFO - 'MOZ_NO_REMOTE': '1', 19:58:05 INFO - 'NO_EM_RESTART': '1', 19:58:05 INFO - 'PAGER': '/bin/cat', 19:58:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:05 INFO - 'PWD': '/builds/slave/test', 19:58:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:05 INFO - 'SHELL': '/bin/bash', 19:58:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:05 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:05 INFO - 'USER': 'cltbld', 19:58:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:05 INFO - 'XPC_FLAGS': '0x0', 19:58:05 INFO - 'XPC_SERVICE_NAME': '0', 19:58:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:58:06 INFO - Cleaning up... 19:58:06 INFO - Return code: 0 19:58:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:58: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')]} 19:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58: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')]} 19:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:06 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:06 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 19:58:06 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 19:58:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:06 INFO - 'HOME': '/Users/cltbld', 19:58:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:06 INFO - 'LOGNAME': 'cltbld', 19:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:06 INFO - 'MOZ_NO_REMOTE': '1', 19:58:06 INFO - 'NO_EM_RESTART': '1', 19:58:06 INFO - 'PAGER': '/bin/cat', 19:58:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:06 INFO - 'PWD': '/builds/slave/test', 19:58:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:06 INFO - 'SHELL': '/bin/bash', 19:58:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:06 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:06 INFO - 'USER': 'cltbld', 19:58:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:06 INFO - 'XPC_FLAGS': '0x0', 19:58:06 INFO - 'XPC_SERVICE_NAME': '0', 19:58:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:06 INFO - Downloading/unpacking blobuploader==1.2.4 19:58:06 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 19:58:06 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 19:58:06 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 19:58:06 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 19:58:06 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 19:58:06 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 19:58:08 INFO - Downloading blobuploader-1.2.4.tar.gz 19:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:58:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:58:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 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 19:58:09 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 19:58:10 INFO - Downloading docopt-0.6.1.tar.gz 19:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:58:10 INFO - Installing collected packages: blobuploader, requests, docopt 19:58:10 INFO - Running setup.py install for blobuploader 19:58:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:58:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:58:10 INFO - Running setup.py install for requests 19:58:10 INFO - Running setup.py install for docopt 19:58:11 INFO - Successfully installed blobuploader requests docopt 19:58:11 INFO - Cleaning up... 19:58:11 INFO - Return code: 0 19:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:11 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:11 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 19:58:11 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 19:58:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:11 INFO - 'HOME': '/Users/cltbld', 19:58:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:11 INFO - 'LOGNAME': 'cltbld', 19:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:11 INFO - 'MOZ_NO_REMOTE': '1', 19:58:11 INFO - 'NO_EM_RESTART': '1', 19:58:11 INFO - 'PAGER': '/bin/cat', 19:58:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:11 INFO - 'PWD': '/builds/slave/test', 19:58:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:11 INFO - 'SHELL': '/bin/bash', 19:58:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:11 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:11 INFO - 'USER': 'cltbld', 19:58:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:11 INFO - 'XPC_FLAGS': '0x0', 19:58:11 INFO - 'XPC_SERVICE_NAME': '0', 19:58:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-WAwKDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Tp8oGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-6eVXxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_nQMn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8IDnXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:11 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-zzJogh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-5lFbUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Z2dMeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-4ymTIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Jm3bQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-yRO1EN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-bzzs0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-uOa3Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-sgx_ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:12 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-4CydZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-r8KKeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:13 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-GgZQHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:58:13 INFO - Running setup.py install for manifestparser 19:58:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:58:13 INFO - Running setup.py install for mozcrash 19:58:13 INFO - Running setup.py install for mozdebug 19:58:13 INFO - Running setup.py install for mozdevice 19:58:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:58:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:58:13 INFO - Running setup.py install for mozfile 19:58:13 INFO - Running setup.py install for mozhttpd 19:58:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Running setup.py install for mozinfo 19:58:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Running setup.py install for mozInstall 19:58:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Running setup.py install for mozleak 19:58:14 INFO - Running setup.py install for mozlog 19:58:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Running setup.py install for moznetwork 19:58:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:58:14 INFO - Running setup.py install for mozprocess 19:58:15 INFO - Running setup.py install for mozprofile 19:58:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:58:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:58:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:58:15 INFO - Running setup.py install for mozrunner 19:58:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:58:15 INFO - Running setup.py install for mozscreenshot 19:58:15 INFO - Running setup.py install for moztest 19:58:15 INFO - Running setup.py install for mozversion 19:58:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:58:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:58:15 INFO - Cleaning up... 19:58:15 INFO - Return code: 0 19:58:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:15 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')]} 19:58:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:15 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')]} 19:58:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:15 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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:15 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 19:58:15 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 19:58:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:15 INFO - 'HOME': '/Users/cltbld', 19:58:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:15 INFO - 'LOGNAME': 'cltbld', 19:58:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:15 INFO - 'MOZ_NO_REMOTE': '1', 19:58:15 INFO - 'NO_EM_RESTART': '1', 19:58:15 INFO - 'PAGER': '/bin/cat', 19:58:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:15 INFO - 'PWD': '/builds/slave/test', 19:58:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:15 INFO - 'SHELL': '/bin/bash', 19:58:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:15 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:15 INFO - 'USER': 'cltbld', 19:58:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:15 INFO - 'XPC_FLAGS': '0x0', 19:58:15 INFO - 'XPC_SERVICE_NAME': '0', 19:58:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_7E8bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8Xgmmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-KUUg2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-Lf78TQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-UaCVIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-d8vfuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-4ETzKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-0qdXPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:58:16 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)) 19:58:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:58:16 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-oieaX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-VnxaHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-hLVG_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-_HvLzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:58:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-TOmuhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-8PcIm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-rnalht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-HGivuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:58:17 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)) 19:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:58:17 INFO - Running setup.py (path:/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/pip-cBBG0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:58:17 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)) 19:58:17 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)) 19:58:17 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)) 19:58:17 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)) 19:58:17 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)) 19:58:17 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)) 19:58:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:58:17 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 19:58:17 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 19:58:17 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 19:58:17 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 19:58:17 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 19:58:17 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 19:58:20 INFO - Downloading blessings-1.6.tar.gz 19:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:58:20 INFO - Installing collected packages: blessings 19:58:20 INFO - Running setup.py install for blessings 19:58:20 INFO - Successfully installed blessings 19:58:20 INFO - Cleaning up... 19:58:20 INFO - Return code: 0 19:58:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:58:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:21 INFO - Reading from file tmpfile_stdout 19:58:21 INFO - Current package versions: 19:58:21 INFO - blessings == 1.6 19:58:21 INFO - blobuploader == 1.2.4 19:58:21 INFO - docopt == 0.6.1 19:58:21 INFO - functools32 == 3.2.3-2 19:58:21 INFO - jsonschema == 2.5.1 19:58:21 INFO - manifestparser == 1.1 19:58:21 INFO - mozInstall == 1.12 19:58:21 INFO - mozcrash == 1.0 19:58:21 INFO - mozdebug == 0.1 19:58:21 INFO - mozdevice == 0.49 19:58:21 INFO - mozfile == 1.2 19:58:21 INFO - mozhttpd == 0.7 19:58:21 INFO - mozinfo == 0.9 19:58:21 INFO - mozleak == 0.1 19:58:21 INFO - mozlog == 3.4 19:58:21 INFO - moznetwork == 0.27 19:58:21 INFO - mozprocess == 0.24 19:58:21 INFO - mozprofile == 0.28 19:58:21 INFO - mozrunner == 6.13 19:58:21 INFO - mozscreenshot == 0.1 19:58:21 INFO - mozsystemmonitor == 0.3 19:58:21 INFO - moztest == 0.8 19:58:21 INFO - mozversion == 1.4 19:58:21 INFO - psutil == 3.1.1 19:58:21 INFO - requests == 1.2.3 19:58:21 INFO - wsgiref == 0.1.2 19:58:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:21 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 19:58:21 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 19:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:21 INFO - 'HOME': '/Users/cltbld', 19:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:21 INFO - 'LOGNAME': 'cltbld', 19:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:21 INFO - 'MOZ_NO_REMOTE': '1', 19:58:21 INFO - 'NO_EM_RESTART': '1', 19:58:21 INFO - 'PAGER': '/bin/cat', 19:58:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:21 INFO - 'PWD': '/builds/slave/test', 19:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:21 INFO - 'SHELL': '/bin/bash', 19:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:21 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:21 INFO - 'USER': 'cltbld', 19:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:21 INFO - 'XPC_FLAGS': '0x0', 19:58:21 INFO - 'XPC_SERVICE_NAME': '0', 19:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 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)) 19:58:22 INFO - Cleaning up... 19:58:22 INFO - Return code: 0 19:58:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10adcab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10adcd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f829255c1b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, '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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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 19:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:58:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:22 INFO - 'HOME': '/Users/cltbld', 19:58:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:22 INFO - 'LOGNAME': 'cltbld', 19:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:22 INFO - 'MOZ_NO_REMOTE': '1', 19:58:22 INFO - 'NO_EM_RESTART': '1', 19:58:22 INFO - 'PAGER': '/bin/cat', 19:58:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:22 INFO - 'PWD': '/builds/slave/test', 19:58:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:22 INFO - 'SHELL': '/bin/bash', 19:58:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:22 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:22 INFO - 'USER': 'cltbld', 19:58:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:22 INFO - 'XPC_FLAGS': '0x0', 19:58:22 INFO - 'XPC_SERVICE_NAME': '0', 19:58:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:58:22 INFO - Cleaning up... 19:58:22 INFO - Return code: 0 19:58:22 INFO - Running post-action listener: _resource_record_post_action 19:58:22 INFO - Running post-action listener: _start_resource_monitoring 19:58:22 INFO - Starting resource monitoring. 19:58:22 INFO - [mozharness: 2017-01-28 03:58:22.951153Z] Finished create-virtualenv step (success) 19:58:22 INFO - [mozharness: 2017-01-28 03:58:22.952076Z] Running install step. 19:58:22 INFO - Running pre-action listener: _resource_record_pre_action 19:58:22 INFO - Running main action method: install 19:58:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:58:23 INFO - Reading from file tmpfile_stdout 19:58:23 INFO - Detecting whether we're running mozinstall >=1.0... 19:58:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:58:23 INFO - Reading from file tmpfile_stdout 19:58:23 INFO - Output received: 19:58:23 INFO - Usage: mozinstall [options] installer 19:58:23 INFO - Options: 19:58:23 INFO - -h, --help show this help message and exit 19:58:23 INFO - -d DEST, --destination=DEST 19:58:23 INFO - Directory to install application into. [default: 19:58:23 INFO - "/builds/slave/test"] 19:58:23 INFO - --app=APP Application being installed. [default: firefox] 19:58:23 INFO - mkdir: /builds/slave/test/build/application 19:58:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:58:45 INFO - Reading from file tmpfile_stdout 19:58:45 INFO - Output received: 19:58:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:58:45 INFO - Running post-action listener: _resource_record_post_action 19:58:45 INFO - [mozharness: 2017-01-28 03:58:45.189950Z] Finished install step (success) 19:58:45 INFO - [mozharness: 2017-01-28 03:58:45.190112Z] Running run-tests step. 19:58:45 INFO - Running pre-action listener: _resource_record_pre_action 19:58:45 INFO - Running main action method: run_tests 19:58:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:58:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:58:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:58:45 INFO - 2017-01-27 19:58:45.204 screenresolution[1629:7331] starting screenresolution argv=screenresolution get 19:58:45 INFO - 2017-01-27 19:58:45.207 screenresolution[1629:7331] Display 0: 1600x1200x32@60 19:58:45 INFO - 2017-01-27 19:58:45.213 screenresolution[1630:7334] starting screenresolution argv=screenresolution list 19:58:45 INFO - Available Modes on Display 0 19:58:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:58:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:58:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:58:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:58:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:58:45 INFO - Intel Iris: 19:58:45 INFO - Chipset Model: Intel Iris 19:58:45 INFO - Type: GPU 19:58:45 INFO - Bus: Built-In 19:58:45 INFO - VRAM (Dynamic, Max): 1536 MB 19:58:45 INFO - Vendor: Intel (0x8086) 19:58:45 INFO - Device ID: 0x0a2e 19:58:45 INFO - Revision ID: 0x0009 19:58:45 INFO - Displays: 19:58:45 INFO - Display: 19:58:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:58:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:58:45 INFO - Display Serial Number: 1600x1200 60 19:58:45 INFO - Main Display: Yes 19:58:45 INFO - Mirror: Off 19:58:45 INFO - Online: Yes 19:58:45 INFO - Rotation: Supported 19:58:45 INFO - Return code: 0 19:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:58:45 INFO - Python 2.7.3 19:58:45 INFO - Return code: 0 19:58:45 INFO - grabbing minidump binary from tooltool 19:58:45 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')]} 19:58:45 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 0x10aba8d30>, '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 0x10aacfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab9dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:58:45 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 19:58:45 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 19:58:45 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 19:58:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:58:45 INFO - Return code: 0 19:58:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:58:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:58:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:58:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:58:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:58:45 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/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 19:58:45 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/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0191 --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 19:58:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.SFCdEeUaJT/Render', 19:58:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:58:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:58:45 INFO - 'HOME': '/Users/cltbld', 19:58:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:58:45 INFO - 'LOGNAME': 'cltbld', 19:58:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:58:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:58:45 INFO - 'MOZ_NO_REMOTE': '1', 19:58:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:58:45 INFO - 'NO_EM_RESTART': '1', 19:58:45 INFO - 'PAGER': '/bin/cat', 19:58:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:58:45 INFO - 'PWD': '/builds/slave/test', 19:58:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:58:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:58:45 INFO - 'SHELL': '/bin/bash', 19:58:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mgHjQGTTd6/Listeners', 19:58:45 INFO - 'TMPDIR': '/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/', 19:58:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:58:45 INFO - 'USER': 'cltbld', 19:58:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:58:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:58:45 INFO - 'XPC_FLAGS': '0x0', 19:58:45 INFO - 'XPC_SERVICE_NAME': '0', 19:58:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:58:45 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/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0191', '--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 19:58:45 INFO - mozversion application_buildid: 20170127184008 19:58:45 INFO - mozversion application_changeset: 045d8fe30f546ab08466c9586ce298e6459c2069 19:58:45 INFO - mozversion application_display_name: Nightly 19:58:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:58:45 INFO - mozversion application_name: Firefox 19:58:45 INFO - mozversion application_remotingname: firefox 19:58:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:58:45 INFO - mozversion application_vendor: Mozilla 19:58:45 INFO - mozversion application_version: 54.0a1 19:58:45 INFO - mozversion platform_buildid: 20170127184008 19:58:45 INFO - mozversion platform_changeset: 045d8fe30f546ab08466c9586ce298e6459c2069 19:58:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:58:45 INFO - mozversion platform_version: 54.0a1 19:58:45 INFO - using testdate: 1485575925 19:58:45 INFO - actual date: 1485575925 19:58:45 INFO - starting webserver on 'localhost:49242' 19:58:45 INFO - SUITE-START | Running 2 tests 19:58:45 INFO - TEST-START | dromaeo_css 19:58:45 INFO - operating with platform_type : mac_ 19:58:45 INFO - Initialising browser for dromaeo_css test... 19:58:45 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpaSOxvv/profile http://localhost:49242/getInfo.html) 19:58:48 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 19:58:48 INFO - PROCESS | 1640 | colorDepth:24 19:58:48 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 19:58:48 INFO - PROCESS | 1640 | __metrics 19:58:48 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:58:48 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:58:48 INFO - TEST-INFO | 1640: exit 0 19:58:48 INFO - Browser initialized. 19:58:48 INFO - Running cycle 1/1 for dromaeo_css test... 19:58:48 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpaSOxvv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:59:01 INFO - PROCESS | 1642 | RSS: Main: 236179456 19:59:01 INFO - PROCESS | 1642 | 20:02:04 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 20:02:07 INFO - PROCESS | 1642 | RSS: Main: 427110400 20:02:07 INFO - PROCESS | 1642 | 20:03:51 INFO - PROCESS | 1642 | ************************* 20:03:51 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 20:03:51 INFO - PROCESS | 1642 | 20:03:51 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:03:51 INFO - PROCESS | 1642 | Full stack: 20:03:51 INFO - PROCESS | 1642 | ************************* 20:05:10 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 20:05:10 INFO - PROCESS | 1642 | RSS: Main: 371818496 20:05:10 INFO - PROCESS | 1642 | 20:08:13 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 20:08:13 INFO - PROCESS | 1642 | RSS: Main: 339382272 20:08:13 INFO - PROCESS | 1642 | 20:11:16 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 20:11:16 INFO - PROCESS | 1642 | RSS: Main: 341884928 20:11:16 INFO - PROCESS | 1642 | 20:14:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 20:14:21 INFO - PROCESS | 1642 | RSS: Main: 337879040 20:14:21 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 20:17:24 INFO - PROCESS | 1642 | RSS: Main: 508755968 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | __start_tp_report 20:17:24 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 20:17:24 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 20:17:24 INFO - PROCESS | 1642 | |i|pagename|runs| 20:17:24 INFO - PROCESS | 1642 | |0;dojo.html;3296.522004309377;3301.141703157179;3316.121227874613;3330.7501937354705;3363.831808409579;5503.477169668885;5536.695481748502;5540.390557038728;5572.052751032329;5588.776448942048;5559.221708960748;5560.332760068787;5625.606207565462;5634.408387119355;5684.062129748587;5014.222795466709;5063;5097.643164978453;5109.744512774365;5165.535101840834;4413.764146039114;4955.231939049453;5114.795408183668;5197.454267301936;5200.245964335169;5015.598752099823;5168.379794424655;5178.171492561191;5211.843644690665;5216.765245563959;5065.138926382524;5108.055009823194;5111.591072714211;5113.386393632751;5122.436531981479;4999.025190087934;5021.623378246646;5027.522385373383;5049.697018178921;5055.140626093536;5560.138178582286;5564.749586268627;5572.414896435897;5579.804706835282;5592.328920529562;6107.664078475682;6112.694365281763;6117.755289788403;6121.724522396503;6124.203853499062;6114.8777024459705;6148.600340977822;6148.631082135086;6156.138140660311;6162.938370616282;5631.549476041907;5702.401247868956;5714.000049991277;5732.942670573241;5783.190353350535;5441.966026454961;5960.970195148997;6321.209848768904;6331.271903731038;6339.175907132043;6116.847078822976;6147.231596050494;6149.077638354193;6149.169862068564;6152.415520525632;6066.636001839904;6132.448079672851;6138.386161383826;6171.938280617226;6254;4786.401699787527;6115.816525504242;6129.754809807558;6138.294096178907;6141.6007959482495;6102.389761023951;6125.235451818339;6145.754169833246;6153.107799369066;6202.317745048041;4896.4124305083615;4900.338454308623;4906.411230652345;4913.970613897343;4946.530079642428;4299.269124248885;4386.210482113186;4435.3125265583885;4451.465824101064;4511.052678937394;5572.554195664337;5606.635568688022;5610.382857885629;5630.211770352154;5669.036263835158;6177.96911015442;6279.183706118175;6293.30773614902;6299.370062993756;6304.401081897213;5613.550915926798;5680.8863822723315;5701.230333904869;5701.629394089371;5724.055530837449;5292.708901010405;5352.91970620441;5422.186671999231;5427.1316589345515;5434.565234781208;6271.153394291712;6295.559310848196;6312.053192021233;6325.1144839721555;6334.809955701337;6266.937330626635;6273.404026617464;6275.874482510416;6278.46633036197;6279.560430769802;6273.749050037947;6299.685015749103;6315.273743519554;6334.968325158345;6347.301796802256;6012.428819262163;6091.7563297467605;6123.14276001369;6129.938700612936;6130.795626845359;6095.390460954047;6142.078688196806;6254.2807577129215;6264.404881536247;6268.310485846462;5788.21859049023;5949.3753155918;5981.3719559445635;5984.461398474158;6012.759489620541;5951.672658003678;5984.820455386345;5996.220491336098;5996.95053365668;6023.066424704178;5815.185873977731;5820.156077368673;5821.679807610622;5822.796202133074;5825.126231065374;5984.16221728967;5987.700614969322;5989.610675306091;6003.459688628044;6004.489618382487;5747.051736463437;5797.188393624811;5813.3895940925595;5836.737346819318;5887.911681324698 20:17:24 INFO - PROCESS | 1642 | |1;ext.html;453.39245411149057;465.8346287068091;472.5392742076474;487.702501474101;489.7820469890898;34901.82549087254;41117;41131;41233.17533649325;41371.79314103425;42007.57992420083;42895;43065.70802875911;43112.92217694559;43125;7546.509476883985;8596.355273354524;9079.137481939206;9415.246780257597;9417.717468475923;8465.111163327854;11062.723431914186;11348;11364.943175284112;11569.710757231052;11415.31508109512;11460.083193344512;11469.94265028678;11472.885271147265;11502.769944601103;8344.332453403775;10962.013418792307;11017.724556886062;11046.944765276163;11056.502457389437;8413.83172336556;10996.890031099747;11284.210105292634;11333.546658133664;11495.310281383061;41551.58448415507;41574;41939.790301048604;42057;42068;4002.6597739192202;4021.195760847813;4033.3748269018347;4049.190161967618;4188;31222.687773122434;31394.686053139405;31462.056138315656;31463.685363146305;31474;2862.327353072026;2958.8224706517676;3258.5763850699495;3306.421376259145;3307.58655168104;476341;476864;478286.9999999965;479503;480182;63881.68059159674;64238.67880660567;64338.71322573616;64431;64433.67783161054;64570.031449528295;64943;66368.66815665891;67636.98544521836;67724.64550708958;16194;16457.670846583;16496.92769969948;16506.83493165077;16519.92620479665;11305.547778088949;12624.431900564497;12715.745685086247;12727.23636581808;12772.105952583415;14207.644808879653;18113.909430452764;18141.909290453463;18172.90913545424;18239.63520729578;7408.925910740932;7442.813929651802;7458.925410745932;7491.812704682427;7532.661030253652;781.3007358414187;826.1408135538973;864.349093231924;878.2710350409145;879.8152387998592;29899.40201195964;29992;30331.24171895676;30643.2339191522;30657.014588103404;1027.6095083868083;1064.3454275620593;1073.6993641780314;1083.772407794372;1141.2182654881433;15065.774013389808;15458.768118478232;15574.532764017098;15586.766198507032;15843.445479408165;605988;613243;614773;614955;615515;62307.6884615574;62600.373996259455;62737.05894411587;62776.37223627705;62834;1387.5143699705022;1429.7712366021594;1441.2865631512468;1443.46591761047;1445.2123592641826;28300.85849570739;28345;28515.144545663665;28646.713532865237;28980;52641.7367913158;52950.735246325065;53011.73494132505;53015.734921325144;53165;513047;513277;516107;519383;521544;36854;37102.814485927396;37181;41786;42019.36970945377;44316.33525497056;44543.55456445524;46970.76514617405;47782.76108619435;48519.757401212766;39146.02134946649;39308;40237.798811005756;40379.3943090848;40453.99917218998;38333;38978;39616.40575391314;39860;40158;36709;37032.62967370292;37955.62044379521;37974.62025379711;38091;30092.247693806956;31829.928806947235;32785.85249516255;34198.5801419856;34531.827340863136;24652.753472465047;24775.38061548476;24946.62580061264;25077.498450031264;25260.368490787878 20:17:24 INFO - PROCESS | 1642 | |2;jquery.html;354.48245561480235;382.6364953294369;392.3487011560809;405.18355513640023;411.7714668359059;14941.327640256188;15109.395624175033;17413.738793918084;20446.38660840177;21086.472838179052;21812;22438.55122897541;22554.43613909653;22841.428964275903;23671.289861304187;6513.478921686254;6546.607203567789;6750.527463077587;6813.4208592269715;6871.690773915186;4623.329617205503;6662.467002639777;6780.72877084916;6783.084283621697;6798.218204906425;4861.100696371165;4941.258811178316;7811.140774514827;7915.327197188246;7933.246341597539;7604.809879752995;7825.569593672346;7887.960560197191;7900.32847207988;7935.682572697086;7516.436267279922;7611.695532178762;7716.305532502101;7737.342325902305;7740.342070923978;20546;28704.856475717697;29027.85486072556;29796.70203297961;30327.090187294416;2836.787240956916;2883.9134825955257;2894.52240380337;2926.356201635637;2959.2158078109105;16774.49676509707;17175.656486870317;17608;17788;18287;1580.6206510437528;1948.7174359717903;1981.6333978214077;1991.3030439346257;1998.3205710058505;103401.48299258531;128866.35566822106;140130;167416.16291918585;167728.71119821255;21439.44878548063;22612.886935565544;23238.883805580863;23538.40848090469;23807.667316439107;41271.93640317972;41346.759597212134;41387.58612413897;41430.34278628821;41695.58304416917;6929.3070692930305;8344.207300306462;8663.696770613124;8708.477491350539;8803.911960880308;8346.081930987586;8393.03480099784;8411.663533458715;8520.488770673779;8568.228859402683;4820.421549414093;4825.9034819303415;4832.371791667131;4838.588719958843;4893;2007.718919351292;2035.623409669216;2048.3957232616117;2052.4971382011504;2065.483629092727;1011.1960991012163;1012.4183332502237;1024.5645600619707;1027.8920713325142;1056.9471526423647;21695.132194712034;22014;22029.118835246732;22074.779252207274;22125.778742212373;1000.954003066797;1014.8629934958686;1021.9386836789816;1041.1514615588271;1061.5912873543741;9479.33644644882;10551.525181366856;11518.465937493738;11562.07503399726;11591.420428978687;643272;681817;695083;704197;729335;127734;150409.24795375954;151705;151908;153151;936.7798567336671;947.1286416496839;963.3882484622316;971.9076687714655;975.1711045611315;15213.391464341303;17619.678524110488;18093.728594071363;19154.616907662046;19183.8081619182;47850.8896921699;53801.73099134479;59971.700141499015;61171;61294.628795416684;80123;82534.58732706298;83412;84142.31715365782;84461.15538844533;8041.718539851077;8530.033534406532;8553.61508732096;8640.654373825228;8903.065178156201;9823;10944.45277736094;13304.46782128704;13320.467181312639;13891.652708682364;11509.309441433206;11703.882961170279;11820.645380638594;11929.463174157358;11995.40022998864;11265;11333.320000799979;11566.65300041;11760.470778814803;11809;11592.710182245512;11610.361430121424;11795.705107372385;11983.28100313984;11993.520259189534;8514.148585141436;8587.828243434971;8608.526531040852;8618.698345557876;8653.69712060075;8312.5428101455;10913.945430272797;11881.82177267359;11918.880811192124;11930.42087373767 20:17:24 INFO - PROCESS | 1642 | |3;mootools.html;1429.7998280240768;1439.2587817274102;1446.5443385333626;1456.9635759106027;1457.650163960649;7775.105862825777;8015.519068855858;8176.468529545576;8177.059638141615;8179.836403271938;7134.357907788298;7416.295451932071;7420.851582968337;7779.533228006324;7966.721164759235;2208.514126892081;2244.2257421189665;2244.7979681828633;2246.067881829047;2249.0778780699916;2247.662850572419;2274.192661605131;2281.863088214704;2283.9086436542602;2285.4743409015855;1860.8604354673387;2058.5162486815584;2190.7371115466085;2191.501688075587;2232.6762619420174;1685.713428717115;2252.9098836046537;2256.176495579118;2257.6049191391603;2258.8531745436494;2230.163688616769;2247.2808701215617;2261.5024694567333;2263.321003698884;2265.127925748582;6845.315468453165;8068.556229407381;8177.4684645497855;8185.754427367188;8198.713045043454;4502.7617405213505;4937.555619994182;5043.798248070073;5117.46266642001;5118;3237.4496335623003;3252.447083995726;3394.6944774970125;3463.2900255447826;3467.081223475781;1139.7834411461795;1196.0551164579972;1243.2043492165021;1244.0918129765323;1246.2833870524394;10425.061744443037;10437.739056523571;10545.578176872916;10549.630762923338;10592.947035264851;4370.934435983463;4509.751963642031;4578.542145785462;4631.444226692751;4635.188841952645;8991.730248092568;9119.81760364789;9124;9128.81742365149;9148.908510914938;5118.38579370478;5119.59043276537;5123.001014802077;5130.846074617767;5139.820106296262;4211.220924129046;4325.307950727868;4347.456567929009;4590.563896429834;4600.7469589172915;3671.9632803672157;3725.1245957200035;3796.7911764853197;3831.348670725983;3837.9232415351535;1261.1550261324935;1263.943122559487;1266.6643339515035;1281.2440660010639;1285.4279845468677;778.3267473635378;787.22851605427;792.984140317202;794.5907857453416;794.9880751788728;4868.807142250101;5335.3864305604575;5409.540189083893;5496.945030549643;5513.751881165357;567.7622782334468;568.2499101186477;594.910763385487;597.0864577196895;602.5330368964088;3579.821008949594;3603.4234522476804;3684.778913265213;3695.8706445274825;3755.948334466299;9278.67524636648;9375.718728438158;9616.326857120075;9624.66313679018;9637.469939153274;9511.952440237754;9592.95203523978;9636.42181469114;9654.565544550513;9666.984966578548;6428.325025872216;7296.744613938593;7389.556626602421;7485.326320631169;7615.200403957616;5297.549708274686;5387.676739395649;5446.749102513027;5477.096279113902;5648.661080335193;7394.2975417335265;8936.195742383217;9022.639094436148;9043.864342035007;9046.231070359094;7160.641967901688;7576.62116894142;9005.414648047856;9096.590653420744;9195.86206206894;6383.457406120532;6637.203535575762;6638.767643132467;6796.694148763218;6955.721771129098;7357.0803649543805;7428.145763237081;7434.776956691092;7436.144843343085;7484.850302994018;6635.767748128792;6961.756338528127;7019.719211231493;7047.718091276497;7129.893051604126;6881.10545629065;6886.380225779704;6909.619970901648;6939.444844412334;6943.930560694328;5362.249285100011;6222.004479283293;6260.060990851409;6268.1851359323;6307.400796924285;4810.446798618063;4855.320255164351;4858.441279252931;4891.29076283944;5044.949550504448;4893.339399181065;4990.700557966534;4993.201087825931;5035.16919708244;5044.848654540369 20:17:24 INFO - PROCESS | 1642 | |4;prototype.html;352.4906510092916;362.9239305459313;365.5448966037282;372.5510759534761;373.41374042752886;4357.542458041904;4399.6260317872975;5290.338707661543;5328.387235467922;5362.43694412087;4586;4796.808127674889;5226.3728352597645;5264.447233040523;5323.459899167049;3183.3633273345367;3731.6081811409817;4055.7566546007333;4109.547949725527;4111.239420707164;3499.5100685903867;3617.728670349721;3849.6920246380223;3908.511436070491;4150.443583656129;4086.836526538935;4089.631933126018;4099.713020088595;4123.670106391482;4160.854370097048;3785.772853628791;3851.326017946862;3997.8001099945177;4072.8778136656097;4105.932457561025;3443.466262729281;3592.2815436912724;3601.4237721964623;3616.987243571804;3618.764780289273;4259.74441533509;4626.167289887819;5065.113605119126;5089.236614507817;5168.534831865112;3555;4311.913761724748;4514.616257618107;4594.402727645418;4786.970801277742;5119.539241468248;5278.466336158627;5531.197976293455;5547.890421915633;5585.497305242507;3844.36567966288;3848.634379733921;3857.07430216746;3859.9807000965097;3876.903077423087;4569.428821397325;5017.899642007176;5206.193040078756;5433.592480563973;5666.660000399989;3292.884749033772;3564.7861128332383;3571.8392672329805;3848.3457812171996;3914.9804250978564;3632.8546858125906;3897.0647044709067;3922.5489068757456;3933.567307596162;3946.585608511065;4572.337011133367;4579.046514997808;4581.335706322565;4602.585767280893;4644.349791029259;5137.897242055138;5280.498352656568;5288.113236770971;5559.581582011757;5703.600747947604;1140.948657310423;1193.2422911451117;1282.4677758730022;1283.5122653391652;1283.9037072219435;704.1831475488511;862.7325529085878;873.0352959979132;873.2882700598991;878.0253918150847;4695.506971767915;4771.284307353924;4836.243341295428;4979.253112033151;5019.0965626187635;5060.873478163076;5347.812826551052;5594.0769772987815;5704.828855134353;5713.628614140068;4030.1277581923277;4767.951050768826;5068.898622027539;5087.23691446286;5091.618128640367;2834.135588645483;2862.699416561231;2865.899693510759;2871.3970066285897;2896.9420611587652;4703.905921881612;4985.825496107691;5029.7736601853;5086.880886205029;5260.894782104337;5383.300170977748;5625.774969001276;5661.8393229387875;5699.406769919677;5829.708514574254;5756.42435756421;5897.085951677411;5923.364102974135;5940.673262970492;5968.836076965037;5724.969505488885;5784.363719990882;5801.535877129735;5818.272715910512;5867.589268751147;4706.4822869485015;5724.627899186539;5762.423757624204;5768.010036537388;5781.479666830005;5945.613535120204;5990.3710110439515;6004.8799024020145;6010.699465026643;6044.274687037584;3595.60448350676;3692.5015122958057;3738.0281126906657;3857.922841543097;3900.64894159527;5068.94707643405;5727.770889164387;5805.651660900359;5806.893312078018;5825.883482330414;5078;5497.725113744217;5543.722813859372;5622.943770562242;5645.729710815034;4316.546762590008;5487.20435536837;5571.275734154534;5600.243967064394;5603.55171586264;4715.834945776881;4723.362346083372;5148.43367229597;5467.6719396836315;5565.471280228372;4831.613470922248;5279.762410691605;5449.3460784706085;5583.274174357308;5615.2700148982;4239.25812982733;4475.485319188335;5385.973070134624;5411;5457.645253058538 20:17:24 INFO - PROCESS | 1642 | |5;yui.html;685.5989246290919;699.4992900381133;727.2000799120966;733.4572416411853;810.5825499867569;14295.213763243031;15072;15106.924465377686;15115.319810608522;15127.168005759679;14485.2757362132;14622.780658290134;14789.408423663068;14835.480758173466;14843.777343339858;884.3720958119743;894.1326912894515;905.5019739143478;906.2885634776702;911.7219248129318;883.7260449260717;885.4687187687368;886.9068747781487;887.5029983209391;891.933105017123;726.4261233625456;748.3601520699805;915.1214833759599;942.2650332740474;944.617429940875;927.7031349968013;936.9156775890202;937.9015203403612;939.6523286384013;940.0129863643148;697.930206979298;698.3156506623486;699.9055127557765;701.4844089594144;701.5895701014862;11579.305241685526;12994.350282485839;13620.931895340558;15549.844501555066;15598.610034749108;14135.71728565423;14681.137178250245;14704.705905881929;14813.777793333109;14816.3332650031;11682.41587920609;11704.239224450468;11828.231164974335;11926.165168438212;12074.27554346742;3608.783472991629;3731.2910546995986;3807.5240594925635;3893.5717071122153;3943;89888.10111898863;92466.07533924642;92544;92594.5370273151;93080;11238.606648767254;11306.434678266054;11311.773764524663;11347.773044539063;11454.885451145381;22787.658185127235;23340.533189336456;23440.7655923442;23452.06191752345;23480.178193763135;7443.144038435541;7495.213002634754;7505.887411688829;7576.393888488908;7670.156282808886;3954.2091581683203;4055.9391609125887;4056.229316429869;4059.6752259819737;4063.89840253996;3473.1317170707325;3553.502509648651;3553.893383198508;3568;3595.424732042913;603.903375459933;633.4140919649305;647.3591144766647;649.0588646462649;656.494499235586;634.5336177909234;668.7859884836805;671.6876652356677;673.8685956238585;682.3722175598461;9994.850077248848;10057.145142662956;10075.461981817833;10131.696049118538;10333;687.6355531568177;687.7214728035153;694.1972232111035;702.0583754070428;702.255609054404;4033.0723933494874;4757.238841785298;4854.368932038812;4877.512248775165;4877.585405240594;102446;102792;103980.96019039865;104955;107572;92919;92952;93872;94036;97503.51248243856;73278.63360683163;77347.61326193334;78874.99999999885;80598.59700701458;80743.19256807357;9569.808603828023;9576.56905439243;9593.232541396812;9605.807883842424;9616.23070154372;52576;53627.92744145017;53856.19215711689;54158;54418.45581544134;69553;71089.64455177692;72167.27832721606;73465.89801153094;75306;11267.154963377943;11915.344656044;11925.880741192477;12058.336791476553;12209.206401583868;12475.563355282522;12627.747445050863;12829.743405132032;12998;13429.26139062361;11902;11918.284902905853;12101;12145.089118315986;12311.881114329564;9530.571124299562;11991.460384282902;12126.27242365461;12130.150889437655;12368.567100151451;10767.784644306914;11052.392118433563;11782.587609433629;12244.448999794853;12345.691357716129;9619.960771428901;9865.047501689402;9871;9992.00079992024;10275.948620256851;7583.924160758322;8526.786830329043;9459.479728614717;9493;9520.61917523319 20:17:24 INFO - PROCESS | 1642 | __end_tp_report 20:17:24 INFO - PROCESS | 1642 | __start_cc_report 20:17:24 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,2991 20:17:24 INFO - PROCESS | 1642 | __end_cc_report 20:17:24 INFO - PROCESS | 1642 | __startTimestamp1485577044684__endTimestamp 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | ------- Summary: start ------- 20:17:24 INFO - PROCESS | 1642 | Number of tests: 6 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5661.42 Median:5820.16 stddev:648.29 (11.1%) stddev-sans-first:623.17 20:17:24 INFO - PROCESS | 1642 | Values: 3296.5 3301.1 3316.1 3330.8 3363.8 5503.5 5536.7 5540.4 5572.1 5588.8 5559.2 5560.3 5625.6 5634.4 5684.1 5014.2 5063.0 5097.6 5109.7 5165.5 4413.8 4955.2 5114.8 5197.5 5200.2 5015.6 5168.4 5178.2 5211.8 5216.8 5065.1 5108.1 5111.6 5113.4 5122.4 4999.0 5021.6 5027.5 5049.7 5055.1 5560.1 5564.7 5572.4 5579.8 5592.3 6107.7 6112.7 6117.8 6121.7 6124.2 6114.9 6148.6 6148.6 6156.1 6162.9 5631.5 5702.4 5714.0 5732.9 5783.2 5442.0 5961.0 6321.2 6331.3 6339.2 6116.8 6147.2 6149.1 6149.2 6152.4 6066.6 6132.4 6138.4 6171.9 6254.0 4786.4 6115.8 6129.8 6138.3 6141.6 6102.4 6125.2 6145.8 6153.1 6202.3 4896.4 4900.3 4906.4 4914.0 4946.5 4299.3 4386.2 4435.3 4451.5 4511.1 5572.6 5606.6 5610.4 5630.2 5669.0 6178.0 6279.2 6293.3 6299.4 6304.4 5613.6 5680.9 5701.2 5701.6 5724.1 5292.7 5352.9 5422.2 5427.1 5434.6 6271.2 6295.6 6312.1 6325.1 6334.8 6266.9 6273.4 6275.9 6278.5 6279.6 6273.7 6299.7 6315.3 6335.0 6347.3 6012.4 6091.8 6123.1 6129.9 6130.8 6095.4 6142.1 6254.3 6264.4 6268.3 5788.2 5949.4 5981.4 5984.5 6012.8 5951.7 5984.8 5996.2 5997.0 6023.1 5815.2 5820.2 5821.7 5822.8 5825.1 5984.2 5987.7 5989.6 6003.5 6004.5 5747.1 5797.2 5813.4 5836.7 5887.9 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:68366.00 Median:39738.20 stddev:143554.76 (361.3%) stddev-sans-first:143866.91 20:17:24 INFO - PROCESS | 1642 | Values: 453.4 465.8 472.5 487.7 489.8 34901.8 41117.0 41131.0 41233.2 41371.8 42007.6 42895.0 43065.7 43112.9 43125.0 7546.5 8596.4 9079.1 9415.2 9417.7 8465.1 11062.7 11348.0 11364.9 11569.7 11415.3 11460.1 11469.9 11472.9 11502.8 8344.3 10962.0 11017.7 11046.9 11056.5 8413.8 10996.9 11284.2 11333.5 11495.3 41551.6 41574.0 41939.8 42057.0 42068.0 4002.7 4021.2 4033.4 4049.2 4188.0 31222.7 31394.7 31462.1 31463.7 31474.0 2862.3 2958.8 3258.6 3306.4 3307.6 476341.0 476864.0 478287.0 479503.0 480182.0 63881.7 64238.7 64338.7 64431.0 64433.7 64570.0 64943.0 66368.7 67637.0 67724.6 16194.0 16457.7 16496.9 16506.8 16519.9 11305.5 12624.4 12715.7 12727.2 12772.1 14207.6 18113.9 18141.9 18172.9 18239.6 7408.9 7442.8 7458.9 7491.8 7532.7 781.3 826.1 864.3 878.3 879.8 29899.4 29992.0 30331.2 30643.2 30657.0 1027.6 1064.3 1073.7 1083.8 1141.2 15065.8 15458.8 15574.5 15586.8 15843.4 605988.0 613243.0 614773.0 614955.0 615515.0 62307.7 62600.4 62737.1 62776.4 62834.0 1387.5 1429.8 1441.3 1443.5 1445.2 28300.9 28345.0 28515.1 28646.7 28980.0 52641.7 52950.7 53011.7 53015.7 53165.0 513047.0 513277.0 516107.0 519383.0 521544.0 36854.0 37102.8 37181.0 41786.0 42019.4 44316.3 44543.6 46970.8 47782.8 48519.8 39146.0 39308.0 40237.8 40379.4 40454.0 38333.0 38978.0 39616.4 39860.0 40158.0 36709.0 37032.6 37955.6 37974.6 38091.0 30092.2 31829.9 32785.9 34198.6 34531.8 24652.8 24775.4 24946.6 25077.5 25260.4 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40620.63 Median:2889.22 stddev:115470.88 (3996.6%) stddev-sans-first:115755.23 20:17:24 INFO - PROCESS | 1642 | Values: 354.5 382.6 392.3 405.2 411.8 14941.3 15109.4 17413.7 20446.4 21086.5 21812.0 22438.6 22554.4 22841.4 23671.3 6513.5 6546.6 6750.5 6813.4 6871.7 4623.3 6662.5 6780.7 6783.1 6798.2 4861.1 4941.3 7811.1 7915.3 7933.2 7604.8 7825.6 7888.0 7900.3 7935.7 7516.4 7611.7 7716.3 7737.3 7740.3 20546.0 28704.9 29027.9 29796.7 30327.1 2836.8 2883.9 2894.5 2926.4 2959.2 16774.5 17175.7 17608.0 17788.0 18287.0 1580.6 1948.7 1981.6 1991.3 1998.3 103401.5 128866.4 140130.0 167416.2 167728.7 21439.4 22612.9 23238.9 23538.4 23807.7 41271.9 41346.8 41387.6 41430.3 41695.6 6929.3 8344.2 8663.7 8708.5 8803.9 8346.1 8393.0 8411.7 8520.5 8568.2 4820.4 4825.9 4832.4 4838.6 4893.0 2007.7 2035.6 2048.4 2052.5 2065.5 1011.2 1012.4 1024.6 1027.9 1056.9 21695.1 22014.0 22029.1 22074.8 22125.8 1001.0 1014.9 1021.9 1041.2 1061.6 9479.3 10551.5 11518.5 11562.1 11591.4 643272.0 681817.0 695083.0 704197.0 729335.0 127734.0 150409.2 151705.0 151908.0 153151.0 936.8 947.1 963.4 971.9 975.2 15213.4 17619.7 18093.7 19154.6 19183.8 47850.9 53801.7 59971.7 61171.0 61294.6 80123.0 82534.6 83412.0 84142.3 84461.2 8041.7 8530.0 8553.6 8640.7 8903.1 9823.0 10944.5 13304.5 13320.5 13891.7 11509.3 11703.9 11820.6 11929.5 11995.4 11265.0 11333.3 11566.7 11760.5 11809.0 11592.7 11610.4 11795.7 11983.3 11993.5 8514.1 8587.8 8608.5 8618.7 8653.7 8312.5 10913.9 11881.8 11918.9 11930.4 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5207.03 Median:5218.68 stddev:2823.52 (54.1%) stddev-sans-first:2817.17 20:17:24 INFO - PROCESS | 1642 | Values: 1429.8 1439.3 1446.5 1457.0 1457.7 7775.1 8015.5 8176.5 8177.1 8179.8 7134.4 7416.3 7420.9 7779.5 7966.7 2208.5 2244.2 2244.8 2246.1 2249.1 2247.7 2274.2 2281.9 2283.9 2285.5 1860.9 2058.5 2190.7 2191.5 2232.7 1685.7 2252.9 2256.2 2257.6 2258.9 2230.2 2247.3 2261.5 2263.3 2265.1 6845.3 8068.6 8177.5 8185.8 8198.7 4502.8 4937.6 5043.8 5117.5 5118.0 3237.4 3252.4 3394.7 3463.3 3467.1 1139.8 1196.1 1243.2 1244.1 1246.3 10425.1 10437.7 10545.6 10549.6 10592.9 4370.9 4509.8 4578.5 4631.4 4635.2 8991.7 9119.8 9124.0 9128.8 9148.9 5118.4 5119.6 5123.0 5130.8 5139.8 4211.2 4325.3 4347.5 4590.6 4600.7 3672.0 3725.1 3796.8 3831.3 3837.9 1261.2 1263.9 1266.7 1281.2 1285.4 778.3 787.2 793.0 794.6 795.0 4868.8 5335.4 5409.5 5496.9 5513.8 567.8 568.2 594.9 597.1 602.5 3579.8 3603.4 3684.8 3695.9 3755.9 9278.7 9375.7 9616.3 9624.7 9637.5 9512.0 9593.0 9636.4 9654.6 9667.0 6428.3 7296.7 7389.6 7485.3 7615.2 5297.5 5387.7 5446.7 5477.1 5648.7 7394.3 8936.2 9022.6 9043.9 9046.2 7160.6 7576.6 9005.4 9096.6 9195.9 6383.5 6637.2 6638.8 6796.7 6955.7 7357.1 7428.1 7434.8 7436.1 7484.9 6635.8 6961.8 7019.7 7047.7 7129.9 6881.1 6886.4 6909.6 6939.4 6943.9 5362.2 6222.0 6260.1 6268.2 6307.4 4810.4 4855.3 4858.4 4891.3 5044.9 4893.3 4990.7 4993.2 5035.2 5044.8 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4456.76 Median:4982.54 stddev:1371.16 (27.5%) stddev-sans-first:1339.96 20:17:24 INFO - PROCESS | 1642 | Values: 352.5 362.9 365.5 372.6 373.4 4357.5 4399.6 5290.3 5328.4 5362.4 4586.0 4796.8 5226.4 5264.4 5323.5 3183.4 3731.6 4055.8 4109.5 4111.2 3499.5 3617.7 3849.7 3908.5 4150.4 4086.8 4089.6 4099.7 4123.7 4160.9 3785.8 3851.3 3997.8 4072.9 4105.9 3443.5 3592.3 3601.4 3617.0 3618.8 4259.7 4626.2 5065.1 5089.2 5168.5 3555.0 4311.9 4514.6 4594.4 4787.0 5119.5 5278.5 5531.2 5547.9 5585.5 3844.4 3848.6 3857.1 3860.0 3876.9 4569.4 5017.9 5206.2 5433.6 5666.7 3292.9 3564.8 3571.8 3848.3 3915.0 3632.9 3897.1 3922.5 3933.6 3946.6 4572.3 4579.0 4581.3 4602.6 4644.3 5137.9 5280.5 5288.1 5559.6 5703.6 1140.9 1193.2 1282.5 1283.5 1283.9 704.2 862.7 873.0 873.3 878.0 4695.5 4771.3 4836.2 4979.3 5019.1 5060.9 5347.8 5594.1 5704.8 5713.6 4030.1 4768.0 5068.9 5087.2 5091.6 2834.1 2862.7 2865.9 2871.4 2896.9 4703.9 4985.8 5029.8 5086.9 5260.9 5383.3 5625.8 5661.8 5699.4 5829.7 5756.4 5897.1 5923.4 5940.7 5968.8 5725.0 5784.4 5801.5 5818.3 5867.6 4706.5 5724.6 5762.4 5768.0 5781.5 5945.6 5990.4 6004.9 6010.7 6044.3 3595.6 3692.5 3738.0 3857.9 3900.6 5068.9 5727.8 5805.7 5806.9 5825.9 5078.0 5497.7 5543.7 5622.9 5645.7 4316.5 5487.2 5571.3 5600.2 5603.6 4715.8 4723.4 5148.4 5467.7 5565.5 4831.6 5279.8 5449.3 5583.3 5615.3 4239.3 4475.5 5386.0 5411.0 5457.6 20:17:24 INFO - PROCESS | 1642 | 20:17:24 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20244.99 Median:53742.06 stddev:29252.97 (54.4%) stddev-sans-first:29298.17 20:17:24 INFO - PROCESS | 1642 | Values: 685.6 699.5 727.2 733.5 810.6 14295.2 15072.0 15106.9 15115.3 15127.2 14485.3 14622.8 14789.4 14835.5 14843.8 884.4 894.1 905.5 906.3 911.7 883.7 885.5 886.9 887.5 891.9 726.4 748.4 915.1 942.3 944.6 927.7 936.9 937.9 939.7 940.0 697.9 698.3 699.9 701.5 701.6 11579.3 12994.4 13620.9 15549.8 15598.6 14135.7 14681.1 14704.7 14813.8 14816.3 11682.4 11704.2 11828.2 11926.2 12074.3 3608.8 3731.3 3807.5 3893.6 3943.0 89888.1 92466.1 92544.0 92594.5 93080.0 11238.6 11306.4 11311.8 11347.8 11454.9 22787.7 23340.5 23440.8 23452.1 23480.2 7443.1 7495.2 7505.9 7576.4 7670.2 3954.2 4055.9 4056.2 4059.7 4063.9 3473.1 3553.5 3553.9 3568.0 3595.4 603.9 633.4 647.4 649.1 656.5 634.5 668.8 671.7 673.9 682.4 9994.9 10057.1 10075.5 10131.7 10333.0 687.6 687.7 694.2 702.1 702.3 4033.1 4757.2 4854.4 4877.5 4877.6 102446.0 102792.0 103981.0 104955.0 107572.0 92919.0 92952.0 93872.0 94036.0 97503.5 73278.6 77347.6 78875.0 80598.6 80743.2 9569.8 9576.6 9593.2 9605.8 9616.2 52576.0 53627.9 53856.2 54158.0 54418.5 69553.0 71089.6 72167.3 73465.9 75306.0 11267.2 11915.3 11925.9 12058.3 12209.2 12475.6 12627.7 12829.7 12998.0 13429.3 11902.0 11918.3 12101.0 12145.1 12311.9 9530.6 11991.5 12126.3 12130.2 12368.6 10767.8 11052.4 11782.6 12244.4 12345.7 9620.0 9865.0 9871.0 9992.0 10275.9 7583.9 8526.8 9459.5 9493.0 9520.6 20:17:24 INFO - PROCESS | 1642 | -------- Summary: end -------- 20:17:24 INFO - PROCESS | 1642 | 20:17:25 INFO - TEST-INFO | 1642: exit 0 20:17:25 INFO - TEST-OK | dromaeo_css | took 1119581ms 20:17:25 INFO - TEST-START | kraken 20:17:25 INFO - operating with platform_type : mac_ 20:17:25 INFO - Initialising browser for kraken test... 20:17:25 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpRnhFBr/profile http://localhost:49242/getInfo.html) 20:17:27 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 20:17:27 INFO - PROCESS | 1652 | colorDepth:24 20:17:27 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 20:17:27 INFO - PROCESS | 1652 | __metrics 20:17:27 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:17:27 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:17:28 INFO - TEST-INFO | 1652: exit 0 20:17:28 INFO - Browser initialized. 20:17:28 INFO - Running cycle 1/1 for kraken test... 20:17:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/T/tmpRnhFBr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:17:40 INFO - PROCESS | 1653 | RSS: Main: 236421120 20:17:40 INFO - PROCESS | 1653 | 20:17:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 20:17:44 INFO - PROCESS | 1653 | RSS: Main: 289251328 20:17:44 INFO - PROCESS | 1653 | 20:17:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 20:17:47 INFO - PROCESS | 1653 | RSS: Main: 288141312 20:17:47 INFO - PROCESS | 1653 | 20:17:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 20:17:51 INFO - PROCESS | 1653 | RSS: Main: 381222912 20:17:51 INFO - PROCESS | 1653 | 20:17:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 20:17:54 INFO - PROCESS | 1653 | RSS: Main: 284164096 20:17:54 INFO - PROCESS | 1653 | 20:17:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:17:57 INFO - PROCESS | 1653 | RSS: Main: 287125504 20:17:57 INFO - PROCESS | 1653 | 20:18:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 20:18:00 INFO - PROCESS | 1653 | RSS: Main: 329605120 20:18:00 INFO - PROCESS | 1653 | 20:18:03 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 20:18:04 INFO - PROCESS | 1653 | RSS: Main: 330842112 20:18:04 INFO - PROCESS | 1653 | 20:18:07 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 20:18:07 INFO - PROCESS | 1653 | RSS: Main: 329465856 20:18:07 INFO - PROCESS | 1653 | 20:18:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:18:10 INFO - PROCESS | 1653 | RSS: Main: 302854144 20:18:10 INFO - PROCESS | 1653 | 20:18:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:18:12 INFO - PROCESS | 1653 | RSS: Main: 308690944 20:18:12 INFO - PROCESS | 1653 | 20:18:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:18:15 INFO - PROCESS | 1653 | RSS: Main: 309964800 20:18:15 INFO - PROCESS | 1653 | 20:18:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:18:19 INFO - PROCESS | 1653 | RSS: Main: 330121216 20:18:19 INFO - PROCESS | 1653 | 20:18:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:18:22 INFO - PROCESS | 1653 | RSS: Main: 324001792 20:18:22 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 20:18:24 INFO - PROCESS | 1653 | RSS: Main: 368951296 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | __start_tp_report 20:18:24 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 20:18:24 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 20:18:24 INFO - PROCESS | 1653 | |i|pagename|runs| 20:18:24 INFO - PROCESS | 1653 | |0;ai-astar;115;114;114;113;113;115;113;114;115;114 20:18:24 INFO - PROCESS | 1653 | |1;audio-beat-detection;141;109;110;144;94;114;139;138;131;105 20:18:24 INFO - PROCESS | 1653 | |2;audio-dft;186;182;183;184;183;179;183;186;184;184 20:18:24 INFO - PROCESS | 1653 | |3;audio-fft;78;60;76;111;83;58;69;82;86;83 20:18:24 INFO - PROCESS | 1653 | |4;audio-oscillator;85;71;108;102;98;78;85;67;68;82 20:18:24 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;87;85;88;86;89;98;135;86;88;85 20:18:24 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;94;104;150;149;94;95;95;94;94 20:18:24 INFO - PROCESS | 1653 | |7;imaging-desaturate;85;86;88;84;86;86;85;87;85;87 20:18:24 INFO - PROCESS | 1653 | |8;json-parse-financial;57;54;54;53;54;55;56;55;55;55 20:18:24 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;65;75;74;78;74;73;69;70;69;70 20:18:24 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;88;89;86;86;90;84;86;88;87;87 20:18:24 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;145;147;144;141;143;153;149;139;178;159 20:18:24 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;175;176;173;175;173;174;176;174;173;173 20:18:24 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;67;66;66;68;68;67;66;67;66 20:18:24 INFO - PROCESS | 1653 | __end_tp_report 20:18:24 INFO - PROCESS | 1653 | __start_cc_report 20:18:24 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1975 20:18:24 INFO - PROCESS | 1653 | __end_cc_report 20:18:24 INFO - PROCESS | 1653 | __startTimestamp1485577104798__endTimestamp 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | ------- Summary: start ------- 20:18:24 INFO - PROCESS | 1653 | Number of tests: 14 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 20:18:24 INFO - PROCESS | 1653 | Values: 115.0 114.0 114.0 113.0 113.0 115.0 113.0 114.0 115.0 114.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:122.50 Median:138.50 stddev:18.01 (13.0%) stddev-sans-first:17.81 20:18:24 INFO - PROCESS | 1653 | Values: 141.0 109.0 110.0 144.0 94.0 114.0 139.0 138.0 131.0 105.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.01 (1.1%) stddev-sans-first:1.90 20:18:24 INFO - PROCESS | 1653 | Values: 186.0 182.0 183.0 184.0 183.0 179.0 183.0 186.0 184.0 184.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:78.60 Median:80.00 stddev:15.00 (18.7%) stddev-sans-first:15.91 20:18:24 INFO - PROCESS | 1653 | Values: 78.0 60.0 76.0 111.0 83.0 58.0 69.0 82.0 86.0 83.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:84.40 Median:80.00 stddev:14.34 (17.9%) stddev-sans-first:15.21 20:18:24 INFO - PROCESS | 1653 | Values: 85.0 71.0 108.0 102.0 98.0 78.0 85.0 67.0 68.0 82.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:87.50 stddev:15.33 (17.5%) stddev-sans-first:16.12 20:18:24 INFO - PROCESS | 1653 | Values: 87.0 85.0 88.0 86.0 89.0 98.0 135.0 86.0 88.0 85.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:106.30 Median:94.00 stddev:22.97 (24.4%) stddev-sans-first:23.93 20:18:24 INFO - PROCESS | 1653 | Values: 94.0 94.0 104.0 150.0 149.0 94.0 95.0 95.0 94.0 94.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.20 (1.4%) stddev-sans-first:1.22 20:18:24 INFO - PROCESS | 1653 | Values: 85.0 86.0 88.0 84.0 86.0 86.0 85.0 87.0 85.0 87.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:55.00 stddev:1.14 (2.1%) stddev-sans-first:0.88 20:18:24 INFO - PROCESS | 1653 | Values: 57.0 54.0 54.0 53.0 54.0 55.0 56.0 55.0 55.0 55.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:73.50 stddev:3.77 (5.1%) stddev-sans-first:3.13 20:18:24 INFO - PROCESS | 1653 | Values: 65.0 75.0 74.0 78.0 74.0 73.0 69.0 70.0 69.0 70.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:1.73 (2.0%) stddev-sans-first:1.80 20:18:24 INFO - PROCESS | 1653 | Values: 88.0 89.0 86.0 86.0 90.0 84.0 86.0 88.0 87.0 87.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:148.00 stddev:11.53 (7.8%) stddev-sans-first:12.09 20:18:24 INFO - PROCESS | 1653 | Values: 145.0 147.0 144.0 141.0 143.0 153.0 149.0 139.0 178.0 159.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.20 Median:174.50 stddev:1.23 (0.7%) stddev-sans-first:1.27 20:18:24 INFO - PROCESS | 1653 | Values: 175.0 176.0 173.0 175.0 173.0 174.0 176.0 174.0 173.0 173.0 20:18:24 INFO - PROCESS | 1653 | 20:18:24 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 20:18:24 INFO - PROCESS | 1653 | Values: 67.0 67.0 66.0 66.0 68.0 68.0 67.0 66.0 67.0 66.0 20:18:24 INFO - PROCESS | 1653 | -------- Summary: end -------- 20:18:24 INFO - PROCESS | 1653 | 20:18:25 INFO - TEST-INFO | 1653: exit 0 20:18:25 INFO - TEST-OK | kraken | took 60360ms 20:18:25 INFO - SUITE-END | took 1179s 20:18:25 INFO - Completed test suite (00:19:40) 20:18:25 INFO - javascript benchmark 20:18:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7336.970326738731, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3296.522004309377, 3301.141703157179, 3316.121227874613, 3330.7501937354705, 3363.831808409579, 5503.477169668885, 5536.695481748502, 5540.390557038728, 5572.052751032329, 5588.776448942048, 5559.221708960748, 5560.332760068787, 5625.606207565462, 5634.408387119355, 5684.062129748587, 5014.222795466709, 5063.0, 5097.643164978453, 5109.744512774365, 5165.535101840834, 4413.764146039114, 4955.231939049453, 5114.795408183668, 5197.454267301936, 5200.245964335169, 5015.598752099823, 5168.379794424655, 5178.171492561191, 5211.843644690665, 5216.765245563959, 5065.138926382524, 5108.055009823194, 5111.591072714211, 5113.386393632751, 5122.436531981479, 4999.025190087934, 5021.623378246646, 5027.522385373383, 5049.697018178921, 5055.140626093536, 5560.138178582286, 5564.749586268627, 5572.414896435897, 5579.804706835282, 5592.328920529562, 6107.664078475682, 6112.694365281763, 6117.755289788403, 6121.724522396503, 6124.203853499062, 6114.8777024459705, 6148.600340977822, 6148.631082135086, 6156.138140660311, 6162.938370616282, 5631.549476041907, 5702.401247868956, 5714.000049991277, 5732.942670573241, 5783.190353350535, 5441.966026454961, 5960.970195148997, 6321.209848768904, 6331.271903731038, 6339.175907132043, 6116.847078822976, 6147.231596050494, 6149.077638354193, 6149.169862068564, 6152.415520525632, 6066.636001839904, 6132.448079672851, 6138.386161383826, 6171.938280617226, 6254.0, 4786.401699787527, 6115.816525504242, 6129.754809807558, 6138.294096178907, 6141.6007959482495, 6102.389761023951, 6125.235451818339, 6145.754169833246, 6153.107799369066, 6202.317745048041, 4896.4124305083615, 4900.338454308623, 4906.411230652345, 4913.970613897343, 4946.530079642428, 4299.269124248885, 4386.210482113186, 4435.3125265583885, 4451.465824101064, 4511.052678937394, 5572.554195664337, 5606.635568688022, 5610.382857885629, 5630.211770352154, 5669.036263835158, 6177.96911015442, 6279.183706118175, 6293.30773614902, 6299.370062993756, 6304.401081897213, 5613.550915926798, 5680.8863822723315, 5701.230333904869, 5701.629394089371, 5724.055530837449, 5292.708901010405, 5352.91970620441, 5422.186671999231, 5427.1316589345515, 5434.565234781208, 6271.153394291712, 6295.559310848196, 6312.053192021233, 6325.1144839721555, 6334.809955701337, 6266.937330626635, 6273.404026617464, 6275.874482510416, 6278.46633036197, 6279.560430769802, 6273.749050037947, 6299.685015749103, 6315.273743519554, 6334.968325158345, 6347.301796802256, 6012.428819262163, 6091.7563297467605, 6123.14276001369, 6129.938700612936, 6130.795626845359, 6095.390460954047, 6142.078688196806, 6254.2807577129215, 6264.404881536247, 6268.310485846462, 5788.21859049023, 5949.3753155918, 5981.3719559445635, 5984.461398474158, 6012.759489620541, 5951.672658003678, 5984.820455386345, 5996.220491336098, 5996.95053365668, 6023.066424704178, 5815.185873977731, 5820.156077368673, 5821.679807610622, 5822.796202133074, 5825.126231065374, 5984.16221728967, 5987.700614969322, 5989.610675306091, 6003.459688628044, 6004.489618382487, 5747.051736463437, 5797.188393624811, 5813.3895940925595, 5836.737346819318, 5887.911681324698], "value": 5619.575396920509, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.39245411149057, 465.8346287068091, 472.5392742076474, 487.702501474101, 489.7820469890898, 34901.82549087254, 41117.0, 41131.0, 41233.17533649325, 41371.79314103425, 42007.57992420083, 42895.0, 43065.70802875911, 43112.92217694559, 43125.0, 7546.509476883985, 8596.355273354524, 9079.137481939206, 9415.246780257597, 9417.717468475923, 8465.111163327854, 11062.723431914186, 11348.0, 11364.943175284112, 11569.710757231052, 11415.31508109512, 11460.083193344512, 11469.94265028678, 11472.885271147265, 11502.769944601103, 8344.332453403775, 10962.013418792307, 11017.724556886062, 11046.944765276163, 11056.502457389437, 8413.83172336556, 10996.890031099747, 11284.210105292634, 11333.546658133664, 11495.310281383061, 41551.58448415507, 41574.0, 41939.790301048604, 42057.0, 42068.0, 4002.6597739192202, 4021.195760847813, 4033.3748269018347, 4049.190161967618, 4188.0, 31222.687773122434, 31394.686053139405, 31462.056138315656, 31463.685363146305, 31474.0, 2862.327353072026, 2958.8224706517676, 3258.5763850699495, 3306.421376259145, 3307.58655168104, 476341.0, 476864.0, 478286.9999999965, 479503.0, 480182.0, 63881.68059159674, 64238.67880660567, 64338.71322573616, 64431.0, 64433.67783161054, 64570.031449528295, 64943.0, 66368.66815665891, 67636.98544521836, 67724.64550708958, 16194.0, 16457.670846583, 16496.92769969948, 16506.83493165077, 16519.92620479665, 11305.547778088949, 12624.431900564497, 12715.745685086247, 12727.23636581808, 12772.105952583415, 14207.644808879653, 18113.909430452764, 18141.909290453463, 18172.90913545424, 18239.63520729578, 7408.925910740932, 7442.813929651802, 7458.925410745932, 7491.812704682427, 7532.661030253652, 781.3007358414187, 826.1408135538973, 864.349093231924, 878.2710350409145, 879.8152387998592, 29899.40201195964, 29992.0, 30331.24171895676, 30643.2339191522, 30657.014588103404, 1027.6095083868083, 1064.3454275620593, 1073.6993641780314, 1083.772407794372, 1141.2182654881433, 15065.774013389808, 15458.768118478232, 15574.532764017098, 15586.766198507032, 15843.445479408165, 605988.0, 613243.0, 614773.0, 614955.0, 615515.0, 62307.6884615574, 62600.373996259455, 62737.05894411587, 62776.37223627705, 62834.0, 1387.5143699705022, 1429.7712366021594, 1441.2865631512468, 1443.46591761047, 1445.2123592641826, 28300.85849570739, 28345.0, 28515.144545663665, 28646.713532865237, 28980.0, 52641.7367913158, 52950.735246325065, 53011.73494132505, 53015.734921325144, 53165.0, 513047.0, 513277.0, 516107.0, 519383.0, 521544.0, 36854.0, 37102.814485927396, 37181.0, 41786.0, 42019.36970945377, 44316.33525497056, 44543.55456445524, 46970.76514617405, 47782.76108619435, 48519.757401212766, 39146.02134946649, 39308.0, 40237.798811005756, 40379.3943090848, 40453.99917218998, 38333.0, 38978.0, 39616.40575391314, 39860.0, 40158.0, 36709.0, 37032.62967370292, 37955.62044379521, 37974.62025379711, 38091.0, 30092.247693806956, 31829.928806947235, 32785.85249516255, 34198.5801419856, 34531.827340863136, 24652.753472465047, 24775.38061548476, 24946.62580061264, 25077.498450031264, 25260.368490787878], "value": 20414.61895831425, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.48245561480235, 382.6364953294369, 392.3487011560809, 405.18355513640023, 411.7714668359059, 14941.327640256188, 15109.395624175033, 17413.738793918084, 20446.38660840177, 21086.472838179052, 21812.0, 22438.55122897541, 22554.43613909653, 22841.428964275903, 23671.289861304187, 6513.478921686254, 6546.607203567789, 6750.527463077587, 6813.4208592269715, 6871.690773915186, 4623.329617205503, 6662.467002639777, 6780.72877084916, 6783.084283621697, 6798.218204906425, 4861.100696371165, 4941.258811178316, 7811.140774514827, 7915.327197188246, 7933.246341597539, 7604.809879752995, 7825.569593672346, 7887.960560197191, 7900.32847207988, 7935.682572697086, 7516.436267279922, 7611.695532178762, 7716.305532502101, 7737.342325902305, 7740.342070923978, 20546.0, 28704.856475717697, 29027.85486072556, 29796.70203297961, 30327.090187294416, 2836.787240956916, 2883.9134825955257, 2894.52240380337, 2926.356201635637, 2959.2158078109105, 16774.49676509707, 17175.656486870317, 17608.0, 17788.0, 18287.0, 1580.6206510437528, 1948.7174359717903, 1981.6333978214077, 1991.3030439346257, 1998.3205710058505, 103401.48299258531, 128866.35566822106, 140130.0, 167416.16291918585, 167728.71119821255, 21439.44878548063, 22612.886935565544, 23238.883805580863, 23538.40848090469, 23807.667316439107, 41271.93640317972, 41346.759597212134, 41387.58612413897, 41430.34278628821, 41695.58304416917, 6929.3070692930305, 8344.207300306462, 8663.696770613124, 8708.477491350539, 8803.911960880308, 8346.081930987586, 8393.03480099784, 8411.663533458715, 8520.488770673779, 8568.228859402683, 4820.421549414093, 4825.9034819303415, 4832.371791667131, 4838.588719958843, 4893.0, 2007.718919351292, 2035.623409669216, 2048.3957232616117, 2052.4971382011504, 2065.483629092727, 1011.1960991012163, 1012.4183332502237, 1024.5645600619707, 1027.8920713325142, 1056.9471526423647, 21695.132194712034, 22014.0, 22029.118835246732, 22074.779252207274, 22125.778742212373, 1000.954003066797, 1014.8629934958686, 1021.9386836789816, 1041.1514615588271, 1061.5912873543741, 9479.33644644882, 10551.525181366856, 11518.465937493738, 11562.07503399726, 11591.420428978687, 643272.0, 681817.0, 695083.0, 704197.0, 729335.0, 127734.0, 150409.24795375954, 151705.0, 151908.0, 153151.0, 936.7798567336671, 947.1286416496839, 963.3882484622316, 971.9076687714655, 975.1711045611315, 15213.391464341303, 17619.678524110488, 18093.728594071363, 19154.616907662046, 19183.8081619182, 47850.8896921699, 53801.73099134479, 59971.700141499015, 61171.0, 61294.628795416684, 80123.0, 82534.58732706298, 83412.0, 84142.31715365782, 84461.15538844533, 8041.718539851077, 8530.033534406532, 8553.61508732096, 8640.654373825228, 8903.065178156201, 9823.0, 10944.45277736094, 13304.46782128704, 13320.467181312639, 13891.652708682364, 11509.309441433206, 11703.882961170279, 11820.645380638594, 11929.463174157358, 11995.40022998864, 11265.0, 11333.320000799979, 11566.65300041, 11760.470778814803, 11809.0, 11592.710182245512, 11610.361430121424, 11795.705107372385, 11983.28100313984, 11993.520259189534, 8514.148585141436, 8587.828243434971, 8608.526531040852, 8618.698345557876, 8653.69712060075, 8312.5428101455, 10913.945430272797, 11881.82177267359, 11918.880811192124, 11930.42087373767], "value": 10897.86399686638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1429.7998280240768, 1439.2587817274102, 1446.5443385333626, 1456.9635759106027, 1457.650163960649, 7775.105862825777, 8015.519068855858, 8176.468529545576, 8177.059638141615, 8179.836403271938, 7134.357907788298, 7416.295451932071, 7420.851582968337, 7779.533228006324, 7966.721164759235, 2208.514126892081, 2244.2257421189665, 2244.7979681828633, 2246.067881829047, 2249.0778780699916, 2247.662850572419, 2274.192661605131, 2281.863088214704, 2283.9086436542602, 2285.4743409015855, 1860.8604354673387, 2058.5162486815584, 2190.7371115466085, 2191.501688075587, 2232.6762619420174, 1685.713428717115, 2252.9098836046537, 2256.176495579118, 2257.6049191391603, 2258.8531745436494, 2230.163688616769, 2247.2808701215617, 2261.5024694567333, 2263.321003698884, 2265.127925748582, 6845.315468453165, 8068.556229407381, 8177.4684645497855, 8185.754427367188, 8198.713045043454, 4502.7617405213505, 4937.555619994182, 5043.798248070073, 5117.46266642001, 5118.0, 3237.4496335623003, 3252.447083995726, 3394.6944774970125, 3463.2900255447826, 3467.081223475781, 1139.7834411461795, 1196.0551164579972, 1243.2043492165021, 1244.0918129765323, 1246.2833870524394, 10425.061744443037, 10437.739056523571, 10545.578176872916, 10549.630762923338, 10592.947035264851, 4370.934435983463, 4509.751963642031, 4578.542145785462, 4631.444226692751, 4635.188841952645, 8991.730248092568, 9119.81760364789, 9124.0, 9128.81742365149, 9148.908510914938, 5118.38579370478, 5119.59043276537, 5123.001014802077, 5130.846074617767, 5139.820106296262, 4211.220924129046, 4325.307950727868, 4347.456567929009, 4590.563896429834, 4600.7469589172915, 3671.9632803672157, 3725.1245957200035, 3796.7911764853197, 3831.348670725983, 3837.9232415351535, 1261.1550261324935, 1263.943122559487, 1266.6643339515035, 1281.2440660010639, 1285.4279845468677, 778.3267473635378, 787.22851605427, 792.984140317202, 794.5907857453416, 794.9880751788728, 4868.807142250101, 5335.3864305604575, 5409.540189083893, 5496.945030549643, 5513.751881165357, 567.7622782334468, 568.2499101186477, 594.910763385487, 597.0864577196895, 602.5330368964088, 3579.821008949594, 3603.4234522476804, 3684.778913265213, 3695.8706445274825, 3755.948334466299, 9278.67524636648, 9375.718728438158, 9616.326857120075, 9624.66313679018, 9637.469939153274, 9511.952440237754, 9592.95203523978, 9636.42181469114, 9654.565544550513, 9666.984966578548, 6428.325025872216, 7296.744613938593, 7389.556626602421, 7485.326320631169, 7615.200403957616, 5297.549708274686, 5387.676739395649, 5446.749102513027, 5477.096279113902, 5648.661080335193, 7394.2975417335265, 8936.195742383217, 9022.639094436148, 9043.864342035007, 9046.231070359094, 7160.641967901688, 7576.62116894142, 9005.414648047856, 9096.590653420744, 9195.86206206894, 6383.457406120532, 6637.203535575762, 6638.767643132467, 6796.694148763218, 6955.721771129098, 7357.0803649543805, 7428.145763237081, 7434.776956691092, 7436.144843343085, 7484.850302994018, 6635.767748128792, 6961.756338528127, 7019.719211231493, 7047.718091276497, 7129.893051604126, 6881.10545629065, 6886.380225779704, 6909.619970901648, 6939.444844412334, 6943.930560694328, 5362.249285100011, 6222.004479283293, 6260.060990851409, 6268.1851359323, 6307.400796924285, 4810.446798618063, 4855.320255164351, 4858.441279252931, 4891.29076283944, 5044.949550504448, 4893.339399181065, 4990.700557966534, 4993.201087825931, 5035.16919708244, 5044.848654540369], "value": 4206.971539248113, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.4906510092916, 362.9239305459313, 365.5448966037282, 372.5510759534761, 373.41374042752886, 4357.542458041904, 4399.6260317872975, 5290.338707661543, 5328.387235467922, 5362.43694412087, 4586.0, 4796.808127674889, 5226.3728352597645, 5264.447233040523, 5323.459899167049, 3183.3633273345367, 3731.6081811409817, 4055.7566546007333, 4109.547949725527, 4111.239420707164, 3499.5100685903867, 3617.728670349721, 3849.6920246380223, 3908.511436070491, 4150.443583656129, 4086.836526538935, 4089.631933126018, 4099.713020088595, 4123.670106391482, 4160.854370097048, 3785.772853628791, 3851.326017946862, 3997.8001099945177, 4072.8778136656097, 4105.932457561025, 3443.466262729281, 3592.2815436912724, 3601.4237721964623, 3616.987243571804, 3618.764780289273, 4259.74441533509, 4626.167289887819, 5065.113605119126, 5089.236614507817, 5168.534831865112, 3555.0, 4311.913761724748, 4514.616257618107, 4594.402727645418, 4786.970801277742, 5119.539241468248, 5278.466336158627, 5531.197976293455, 5547.890421915633, 5585.497305242507, 3844.36567966288, 3848.634379733921, 3857.07430216746, 3859.9807000965097, 3876.903077423087, 4569.428821397325, 5017.899642007176, 5206.193040078756, 5433.592480563973, 5666.660000399989, 3292.884749033772, 3564.7861128332383, 3571.8392672329805, 3848.3457812171996, 3914.9804250978564, 3632.8546858125906, 3897.0647044709067, 3922.5489068757456, 3933.567307596162, 3946.585608511065, 4572.337011133367, 4579.046514997808, 4581.335706322565, 4602.585767280893, 4644.349791029259, 5137.897242055138, 5280.498352656568, 5288.113236770971, 5559.581582011757, 5703.600747947604, 1140.948657310423, 1193.2422911451117, 1282.4677758730022, 1283.5122653391652, 1283.9037072219435, 704.1831475488511, 862.7325529085878, 873.0352959979132, 873.2882700598991, 878.0253918150847, 4695.506971767915, 4771.284307353924, 4836.243341295428, 4979.253112033151, 5019.0965626187635, 5060.873478163076, 5347.812826551052, 5594.0769772987815, 5704.828855134353, 5713.628614140068, 4030.1277581923277, 4767.951050768826, 5068.898622027539, 5087.23691446286, 5091.618128640367, 2834.135588645483, 2862.699416561231, 2865.899693510759, 2871.3970066285897, 2896.9420611587652, 4703.905921881612, 4985.825496107691, 5029.7736601853, 5086.880886205029, 5260.894782104337, 5383.300170977748, 5625.774969001276, 5661.8393229387875, 5699.406769919677, 5829.708514574254, 5756.42435756421, 5897.085951677411, 5923.364102974135, 5940.673262970492, 5968.836076965037, 5724.969505488885, 5784.363719990882, 5801.535877129735, 5818.272715910512, 5867.589268751147, 4706.4822869485015, 5724.627899186539, 5762.423757624204, 5768.010036537388, 5781.479666830005, 5945.613535120204, 5990.3710110439515, 6004.8799024020145, 6010.699465026643, 6044.274687037584, 3595.60448350676, 3692.5015122958057, 3738.0281126906657, 3857.922841543097, 3900.64894159527, 5068.94707643405, 5727.770889164387, 5805.651660900359, 5806.893312078018, 5825.883482330414, 5078.0, 5497.725113744217, 5543.722813859372, 5622.943770562242, 5645.729710815034, 4316.546762590008, 5487.20435536837, 5571.275734154534, 5600.243967064394, 5603.55171586264, 4715.834945776881, 4723.362346083372, 5148.43367229597, 5467.6719396836315, 5565.471280228372, 4831.613470922248, 5279.762410691605, 5449.3460784706085, 5583.274174357308, 5615.2700148982, 4239.25812982733, 4475.485319188335, 5385.973070134624, 5411.0, 5457.645253058538], "value": 4034.0637013486667, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.5989246290919, 699.4992900381133, 727.2000799120966, 733.4572416411853, 810.5825499867569, 14295.213763243031, 15072.0, 15106.924465377686, 15115.319810608522, 15127.168005759679, 14485.2757362132, 14622.780658290134, 14789.408423663068, 14835.480758173466, 14843.777343339858, 884.3720958119743, 894.1326912894515, 905.5019739143478, 906.2885634776702, 911.7219248129318, 883.7260449260717, 885.4687187687368, 886.9068747781487, 887.5029983209391, 891.933105017123, 726.4261233625456, 748.3601520699805, 915.1214833759599, 942.2650332740474, 944.617429940875, 927.7031349968013, 936.9156775890202, 937.9015203403612, 939.6523286384013, 940.0129863643148, 697.930206979298, 698.3156506623486, 699.9055127557765, 701.4844089594144, 701.5895701014862, 11579.305241685526, 12994.350282485839, 13620.931895340558, 15549.844501555066, 15598.610034749108, 14135.71728565423, 14681.137178250245, 14704.705905881929, 14813.777793333109, 14816.3332650031, 11682.41587920609, 11704.239224450468, 11828.231164974335, 11926.165168438212, 12074.27554346742, 3608.783472991629, 3731.2910546995986, 3807.5240594925635, 3893.5717071122153, 3943.0, 89888.10111898863, 92466.07533924642, 92544.0, 92594.5370273151, 93080.0, 11238.606648767254, 11306.434678266054, 11311.773764524663, 11347.773044539063, 11454.885451145381, 22787.658185127235, 23340.533189336456, 23440.7655923442, 23452.06191752345, 23480.178193763135, 7443.144038435541, 7495.213002634754, 7505.887411688829, 7576.393888488908, 7670.156282808886, 3954.2091581683203, 4055.9391609125887, 4056.229316429869, 4059.6752259819737, 4063.89840253996, 3473.1317170707325, 3553.502509648651, 3553.893383198508, 3568.0, 3595.424732042913, 603.903375459933, 633.4140919649305, 647.3591144766647, 649.0588646462649, 656.494499235586, 634.5336177909234, 668.7859884836805, 671.6876652356677, 673.8685956238585, 682.3722175598461, 9994.850077248848, 10057.145142662956, 10075.461981817833, 10131.696049118538, 10333.0, 687.6355531568177, 687.7214728035153, 694.1972232111035, 702.0583754070428, 702.255609054404, 4033.0723933494874, 4757.238841785298, 4854.368932038812, 4877.512248775165, 4877.585405240594, 102446.0, 102792.0, 103980.96019039865, 104955.0, 107572.0, 92919.0, 92952.0, 93872.0, 94036.0, 97503.51248243856, 73278.63360683163, 77347.61326193334, 78874.99999999885, 80598.59700701458, 80743.19256807357, 9569.808603828023, 9576.56905439243, 9593.232541396812, 9605.807883842424, 9616.23070154372, 52576.0, 53627.92744145017, 53856.19215711689, 54158.0, 54418.45581544134, 69553.0, 71089.64455177692, 72167.27832721606, 73465.89801153094, 75306.0, 11267.154963377943, 11915.344656044, 11925.880741192477, 12058.336791476553, 12209.206401583868, 12475.563355282522, 12627.747445050863, 12829.743405132032, 12998.0, 13429.26139062361, 11902.0, 11918.284902905853, 12101.0, 12145.089118315986, 12311.881114329564, 9530.571124299562, 11991.460384282902, 12126.27242365461, 12130.150889437655, 12368.567100151451, 10767.784644306914, 11052.392118433563, 11782.587609433629, 12244.448999794853, 12345.691357716129, 9619.960771428901, 9865.047501689402, 9871.0, 9992.00079992024, 10275.948620256851, 7583.924160758322, 8526.786830329043, 9459.479728614717, 9493.0, 9520.61917523319], "value": 7351.041599108778, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1472.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0, 114.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 109.0, 110.0, 144.0, 94.0, 114.0, 139.0, 138.0, 131.0, 105.0], "value": 122.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 182.0, 183.0, 184.0, 183.0, 179.0, 183.0, 186.0, 184.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 76.0, 111.0, 83.0, 58.0, 69.0, 82.0, 86.0, 83.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 108.0, 102.0, 98.0, 78.0, 85.0, 67.0, 68.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 86.0, 89.0, 98.0, 135.0, 86.0, 88.0, 85.0], "value": 92.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 104.0, 150.0, 149.0, 94.0, 95.0, 95.0, 94.0, 94.0], "value": 106.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 88.0, 84.0, 86.0, 86.0, 85.0, 87.0, 85.0, 87.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 53.0, 54.0, 55.0, 56.0, 55.0, 55.0, 55.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 75.0, 74.0, 78.0, 74.0, 73.0, 69.0, 70.0, 69.0, 70.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 86.0, 86.0, 90.0, 84.0, 86.0, 88.0, 87.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 144.0, 141.0, 143.0, 153.0, 149.0, 139.0, 178.0, 159.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 173.0, 175.0, 173.0, 174.0, 176.0, 174.0, 173.0, 173.0], "value": 174.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 66.0, 68.0, 68.0, 67.0, 66.0, 67.0, 66.0], "value": 66.8, "unit": "score"}]}]} 20:18:26 INFO - Return code: 0 20:18:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:18:26 ERROR - # TBPL SUCCESS # 20:18:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:18:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:18:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:18:26 INFO - 2017-01-27 20:18:26.099 screenresolution[1657:9705] starting screenresolution argv=screenresolution get 20:18:26 INFO - 2017-01-27 20:18:26.102 screenresolution[1657:9705] Display 0: 1600x1200x32@60 20:18:26 INFO - 2017-01-27 20:18:26.109 screenresolution[1658:9708] starting screenresolution argv=screenresolution list 20:18:26 INFO - Available Modes on Display 0 20:18:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:18:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:18:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:18:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:18:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:18:26 INFO - Intel Iris: 20:18:26 INFO - Chipset Model: Intel Iris 20:18:26 INFO - Type: GPU 20:18:26 INFO - Bus: Built-In 20:18:26 INFO - VRAM (Dynamic, Max): 1536 MB 20:18:26 INFO - Vendor: Intel (0x8086) 20:18:26 INFO - Device ID: 0x0a2e 20:18:26 INFO - Revision ID: 0x0009 20:18:26 INFO - Displays: 20:18:26 INFO - Display: 20:18:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:18:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:18:26 INFO - Display Serial Number: 1600x1200 60 20:18:26 INFO - Main Display: Yes 20:18:26 INFO - Mirror: Off 20:18:26 INFO - Online: Yes 20:18:26 INFO - Rotation: Supported 20:18:26 INFO - Return code: 0 20:18:26 INFO - Running post-action listener: _resource_record_post_action 20:18:26 INFO - [mozharness: 2017-01-28 04:18:26.345991Z] Finished run-tests step (success) 20:18:26 INFO - Running post-run listener: _resource_record_post_run 20:18:26 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 38843392; Write bytes: 551643136; Read time: 392; Write time: 1922 20:18:26 INFO - TinderboxPrint: CPU usage
53.7% 20:18:26 INFO - TinderboxPrint: I/O read bytes / time
38,843,392 / 392 20:18:26 INFO - TinderboxPrint: I/O write bytes / time
551,643,136 / 1,922 20:18:26 INFO - TinderboxPrint: CPU idle
2,225.1 (46.3%) 20:18:26 INFO - TinderboxPrint: CPU system
961.9 (20.0%) 20:18:26 INFO - TinderboxPrint: CPU user
1,622.8 (33.7%) 20:18:26 INFO - TinderboxPrint: Swap in / out
290,500,608 / 0 20:18:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250591744; Write bytes: 244606464; Read time: 18136; Write time: 486 20:18:26 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 34608128; Write bytes: 295739904; Read time: 357; Write time: 1397 20:18:26 INFO - Running post-run listener: _upload_blobber_files 20:18:26 INFO - Blob upload gear active. 20:18:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:18:26 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 20:18:26 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'] 20:18:26 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 20:18:27 INFO - (blobuploader) - INFO - Open directory for files ... 20:18:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:18:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:18:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:28 INFO - (blobuploader) - INFO - Done attempting. 20:18:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:18:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:18:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:29 INFO - (blobuploader) - INFO - Done attempting. 20:18:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:18:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:18:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:30 INFO - (blobuploader) - INFO - Done attempting. 20:18:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:18:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:18:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:18:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:18:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:18:32 INFO - (blobuploader) - INFO - Done attempting. 20:18:32 INFO - (blobuploader) - INFO - Iteration through files over. 20:18:32 INFO - Return code: 0 20:18:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:18:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:18:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101d430553624793b8690cbc5099cae9ebda789b1b1b16c4eb08bc715ee5cd3ba0604de184846f04e1cd654e55f7937cbc6e358f1ff25a7c27ef8b2af41da945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78287bc24d3af6b93b2210816fe6c37e98078acc6de3d7efefc376ae4b6bb704c21615cd84f9d6a1cb5ae29b14af388f11b080e67a3d7036b12d4a109a379cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fc6c55af114e322d09624f494cb3bfdff83d3218c8b38d3f97de88952083cc2a5b39db9c4b67ff4be54805f0b86a28556aae004773b86167968cf4accfe603b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93327fddaaec17c393cd1d910c1b5fc0b905def1ddb322b0139913856935bad6f5f4c6c055bbfe8625a0a2d65b35eaa5c1de0ba0072d58a8b62bfe4b0e71f3e3"} 20:18:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:18:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:18:32 INFO - Contents: 20:18:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101d430553624793b8690cbc5099cae9ebda789b1b1b16c4eb08bc715ee5cd3ba0604de184846f04e1cd654e55f7937cbc6e358f1ff25a7c27ef8b2af41da945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78287bc24d3af6b93b2210816fe6c37e98078acc6de3d7efefc376ae4b6bb704c21615cd84f9d6a1cb5ae29b14af388f11b080e67a3d7036b12d4a109a379cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fc6c55af114e322d09624f494cb3bfdff83d3218c8b38d3f97de88952083cc2a5b39db9c4b67ff4be54805f0b86a28556aae004773b86167968cf4accfe603b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93327fddaaec17c393cd1d910c1b5fc0b905def1ddb322b0139913856935bad6f5f4c6c055bbfe8625a0a2d65b35eaa5c1de0ba0072d58a8b62bfe4b0e71f3e3"} 20:18:32 INFO - Running post-run listener: copy_logs_to_upload_dir 20:18:32 INFO - Copying logs to upload dir... 20:18:32 INFO - mkdir: /builds/slave/test/build/upload/logs 20:18:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.660408 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-27 20:18:32.619223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:32.625484) ========= 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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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/101d430553624793b8690cbc5099cae9ebda789b1b1b16c4eb08bc715ee5cd3ba0604de184846f04e1cd654e55f7937cbc6e358f1ff25a7c27ef8b2af41da945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78287bc24d3af6b93b2210816fe6c37e98078acc6de3d7efefc376ae4b6bb704c21615cd84f9d6a1cb5ae29b14af388f11b080e67a3d7036b12d4a109a379cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fc6c55af114e322d09624f494cb3bfdff83d3218c8b38d3f97de88952083cc2a5b39db9c4b67ff4be54805f0b86a28556aae004773b86167968cf4accfe603b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93327fddaaec17c393cd1d910c1b5fc0b905def1ddb322b0139913856935bad6f5f4c6c055bbfe8625a0a2d65b35eaa5c1de0ba0072d58a8b62bfe4b0e71f3e3"} build_url:https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010971 build_url: 'https://queue.taskcluster.net/v1/task/QHj39I6mThSLNoeakqGKqw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/101d430553624793b8690cbc5099cae9ebda789b1b1b16c4eb08bc715ee5cd3ba0604de184846f04e1cd654e55f7937cbc6e358f1ff25a7c27ef8b2af41da945", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78287bc24d3af6b93b2210816fe6c37e98078acc6de3d7efefc376ae4b6bb704c21615cd84f9d6a1cb5ae29b14af388f11b080e67a3d7036b12d4a109a379cab", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fc6c55af114e322d09624f494cb3bfdff83d3218c8b38d3f97de88952083cc2a5b39db9c4b67ff4be54805f0b86a28556aae004773b86167968cf4accfe603b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/93327fddaaec17c393cd1d910c1b5fc0b905def1ddb322b0139913856935bad6f5f4c6c055bbfe8625a0a2d65b35eaa5c1de0ba0072d58a8b62bfe4b0e71f3e3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:32.668911) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:32.669263) ========= 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.SFCdEeUaJT/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.mgHjQGTTd6/Listeners TMPDIR=/var/folders/dh/20gh1mt515501fbg9wc6h1q800000w/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.005070 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-27 20:18:32.719936) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 20:18:32.722292) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-27 20:18:32.722620) ========= ========= Total master_lag: 0.22 =========