builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0037 starttime: 1481124724.75 results: success (0) buildid: 20161207062538 builduid: b56b1ebfee5743d2bd842d23b787158f revision: 93266100e27057f116effff38f70d8563533097b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:04.753254) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:04.753810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:04.754130) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:04.780002) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:04.780342) ========= 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.PeGmouhOfR/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.F8wd67ZidR/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-12-07 07:32:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.39M=0.002s 2016-12-07 07:32:05 (7.39 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.583870 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:05.388687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:05.389050) ========= 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.PeGmouhOfR/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.F8wd67ZidR/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.020994 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:05.438545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:05.438966) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93266100e27057f116effff38f70d8563533097b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93266100e27057f116effff38f70d8563533097b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PeGmouhOfR/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.F8wd67ZidR/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-12-07 07:32:05,505 truncating revision to first 12 chars 2016-12-07 07:32:05,505 Setting DEBUG logging. 2016-12-07 07:32:05,505 attempt 1/10 2016-12-07 07:32:05,505 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/93266100e270?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 07:32:06,212 unpacking tar archive at: mozilla-aurora-93266100e270/testing/mozharness/ program finished with exit code 0 elapsedTime=0.947720 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:06.408440) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:06.408813) ========= script_repo_revision: 93266100e27057f116effff38f70d8563533097b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:06.409274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:06.409600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:32:06.428622) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-07 07:32:06.429062) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PeGmouhOfR/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.F8wd67ZidR/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:06 INFO - MultiFileLogger online at 20161207 07:32:06 in /builds/slave/test 07:32:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:32:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:06 INFO - {'append_to_log': False, 07:32:06 INFO - 'base_work_dir': '/builds/slave/test', 07:32:06 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:32:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:06 INFO - 'branch': 'Mozilla-Aurora', 07:32:06 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:06 INFO - 'config_files': ('talos/mac_config.py',), 07:32:06 INFO - 'default_actions': ('clobber', 07:32:06 INFO - 'read-buildbot-config', 07:32:06 INFO - 'download-and-extract', 07:32:06 INFO - 'populate-webroot', 07:32:06 INFO - 'create-virtualenv', 07:32:06 INFO - 'install', 07:32:06 INFO - 'run-tests'), 07:32:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:06 INFO - 'download_minidump_stackwalk': True, 07:32:06 INFO - 'download_symbols': 'ondemand', 07:32:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:06 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:06 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:06 INFO - 'installer_path': 'installer.exe', 07:32:06 INFO - 'log_level': 'info', 07:32:06 INFO - 'log_name': 'talos', 07:32:06 INFO - 'log_to_console': True, 07:32:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:32:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:32:06 INFO - 'opt_config_files': (), 07:32:06 INFO - 'pip_index': False, 07:32:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:32:06 INFO - 'cmd': ('bash', 07:32:06 INFO - '-c', 07:32:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:32:06 INFO - 'enabled': True, 07:32:06 INFO - 'halt_on_failure': False, 07:32:06 INFO - 'name': 'check_screen_resolution'},), 07:32:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:32:06 INFO - 'cmd': ('bash', 07:32:06 INFO - '-c', 07:32:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:32:06 INFO - 'enabled': True, 07:32:06 INFO - 'halt_on_failure': False, 07:32:06 INFO - 'name': 'check_screen_resolution'},), 07:32:06 INFO - 'run_cmd_checks_enabled': True, 07:32:06 INFO - 'sps_profile': False, 07:32:06 INFO - 'sps_profile_interval': 0, 07:32:06 INFO - 'suite': 'dromaeojs-e10s', 07:32:06 INFO - 'system_bits': '32', 07:32:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:06 INFO - 'title': 't-yosemite-r7-0037', 07:32:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:06 INFO - 'use_talos_json': True, 07:32:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:06 INFO - 'work_dir': 'build'} 07:32:06 INFO - [mozharness: 2016-12-07 15:32:06.624413Z] Running clobber step. 07:32:06 INFO - Running pre-action listener: _resource_record_pre_action 07:32:06 INFO - Running main action method: clobber 07:32:06 INFO - rmtree: /builds/slave/test/build 07:32:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:07 INFO - Running post-action listener: _resource_record_post_action 07:32:07 INFO - [mozharness: 2016-12-07 15:32:07.796313Z] Finished clobber step (success) 07:32:07 INFO - [mozharness: 2016-12-07 15:32:07.796466Z] Running read-buildbot-config step. 07:32:07 INFO - Running pre-action listener: _resource_record_pre_action 07:32:07 INFO - Running main action method: read_buildbot_config 07:32:07 INFO - Using buildbot properties: 07:32:07 INFO - { 07:32:07 INFO - "project": "", 07:32:07 INFO - "product": "firefox", 07:32:07 INFO - "script_repo_revision": "production", 07:32:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 07:32:07 INFO - "repository": "", 07:32:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 07:32:07 INFO - "buildid": "20161207062538", 07:32:07 INFO - "pgo_build": "False", 07:32:07 INFO - "basedir": "/builds/slave/test", 07:32:07 INFO - "buildnumber": 49, 07:32:07 INFO - "slavename": "t-yosemite-r7-0037", 07:32:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:32:07 INFO - "platform": "yosemite_r7", 07:32:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:32:07 INFO - "branch": "mozilla-aurora", 07:32:07 INFO - "repo_path": "releases/mozilla-aurora", 07:32:07 INFO - "revision": "93266100e27057f116effff38f70d8563533097b", 07:32:07 INFO - "stage_platform": "macosx64", 07:32:07 INFO - "builduid": "b56b1ebfee5743d2bd842d23b787158f", 07:32:07 INFO - "slavebuilddir": "test" 07:32:07 INFO - } 07:32:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 07:32:07 INFO - Running post-action listener: _resource_record_post_action 07:32:07 INFO - [mozharness: 2016-12-07 15:32:07.799464Z] Finished read-buildbot-config step (success) 07:32:07 INFO - [mozharness: 2016-12-07 15:32:07.799573Z] Running download-and-extract step. 07:32:07 INFO - Running pre-action listener: _resource_record_pre_action 07:32:07 INFO - Running main action method: download_and_extract 07:32:07 INFO - mkdir: /builds/slave/test/build/tests 07:32:07 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')]} 07:32:07 INFO - trying https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 07:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 07:32:08 INFO - Downloaded 1199 bytes. 07:32:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 07:32:08 INFO - Using the following test package requirements: 07:32:08 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:32:08 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 07:32:08 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 07:32:08 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'jsshell-mac.zip'], 07:32:08 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 07:32:08 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 07:32:08 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 07:32:08 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 07:32:08 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 07:32:08 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 07:32:08 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 07:32:08 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:32:09 INFO - Http code: 200 07:32:09 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 07:32:09 INFO - x-amz-cf-id: Sd9Ri_WTcnrN8jaZpB157WPEzA8X7f8A-A10zF8uJJHRpfKElwk4eA== 07:32:09 INFO - x-amz-version-id: Ghz5yaORMF3NCjhtS_XWMRCbQaPNh6qG 07:32:09 INFO - Expected file size: 16281930 07:32:09 INFO - Obtained file size: 16281930 07:32:16 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 07:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 07:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 07:32:16 INFO - Http code: 200 07:32:16 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 07:32:16 INFO - x-amz-cf-id: ML5iTdlZTzHtZbo1VMFFsDskfUSYKaqob4Wq48S8ohBw-VmU9wwXeQ== 07:32:16 INFO - x-amz-version-id: Ghz5yaORMF3NCjhtS_XWMRCbQaPNh6qG 07:32:16 INFO - Expected file size: 16281930 07:32:16 INFO - Obtained file size: 16281930 07:32:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 07:32:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:32:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 07:32:25 INFO - Http code: 200 07:32:25 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 07:32:25 INFO - x-amz-cf-id: FLbtKNGLSsSy-mypfB9my66JJruOzgRzgnsT0W_0SiNL4FGjQiouig== 07:32:25 INFO - x-amz-version-id: fSeIFnIywqSiYvpkFeAO7qO.zU6rHKRe 07:32:25 INFO - Expected file size: 14409038 07:32:25 INFO - Obtained file size: 14409038 07:32:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:26 INFO - trying https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:32:26 INFO - Downloading https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 07:32:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 07:32:29 INFO - Downloaded 109764960 bytes. 07:32:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:32:29 INFO - mkdir: /builds/slave/test/properties 07:32:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:29 INFO - Contents: 07:32:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 07:32:29 INFO - Running post-action listener: _resource_record_post_action 07:32:29 INFO - Running post-action listener: set_extra_try_arguments 07:32:29 INFO - [mozharness: 2016-12-07 15:32:29.784623Z] Finished download-and-extract step (success) 07:32:29 INFO - [mozharness: 2016-12-07 15:32:29.784740Z] Running populate-webroot step. 07:32:29 INFO - Running pre-action listener: _resource_record_pre_action 07:32:29 INFO - Running main action method: populate_webroot 07:32:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:29 INFO - '--tppagecycles', 07:32:29 INFO - '7'], 07:32:29 INFO - 'tests': ['tsvgm']}}, 07:32:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['damp', 'tps']}, 07:32:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'tests': ['damp', 'tps']}, 07:32:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['dromaeo_dom']}, 07:32:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['basic_compositor_video']}, 07:32:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['a11yr', 07:32:29 INFO - 'ts_paint', 07:32:29 INFO - 'tpaint', 07:32:29 INFO - 'sessionrestore', 07:32:29 INFO - 'sessionrestore_no_auto_restore', 07:32:29 INFO - 'tabpaint']}, 07:32:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tsvgx', 07:32:29 INFO - 'tsvgr_opacity', 07:32:29 INFO - 'tart', 07:32:29 INFO - 'tscrollx', 07:32:29 INFO - 'cart']}, 07:32:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:29 INFO - 'tsvgr_opacity', 07:32:29 INFO - 'tart', 07:32:29 INFO - 'tscrollx', 07:32:29 INFO - 'cart']}, 07:32:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s'], 07:32:29 INFO - 'tests': ['tp5o']}, 07:32:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'tests': ['tp5o']}, 07:32:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--disable-e10s', 07:32:29 INFO - '--xperf_path', 07:32:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:29 INFO - 'tests': ['tp5n']}, 07:32:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:29 INFO - 'talos_options': ['--xperf_path', 07:32:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:29 INFO - 'tests': ['tp5n']}}, 07:32:29 INFO - 'talos.zip': {'path': '', 07:32:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:29 INFO - Running post-action listener: _resource_record_post_action 07:32:29 INFO - [mozharness: 2016-12-07 15:32:29.803281Z] Finished populate-webroot step (success) 07:32:29 INFO - [mozharness: 2016-12-07 15:32:29.803367Z] Running create-virtualenv step. 07:32:29 INFO - Running pre-action listener: _resource_record_pre_action 07:32:29 INFO - Running main action method: create_virtualenv 07:32:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:29 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 07:32:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:29 INFO - Using real prefix '/tools/python27' 07:32:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:33 INFO - Installing pip.................done. 07:32:33 INFO - Return code: 0 07:32:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:32:33 INFO - Reading from file tmpfile_stdout 07:32:33 INFO - Output received: 07:32:33 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) 07:32:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:33 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:33 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 07:32:33 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 07:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:33 INFO - 'HOME': '/Users/cltbld', 07:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:33 INFO - 'LOGNAME': 'cltbld', 07:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:33 INFO - 'MOZ_NO_REMOTE': '1', 07:32:33 INFO - 'NO_EM_RESTART': '1', 07:32:33 INFO - 'PAGER': '/bin/cat', 07:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:33 INFO - 'PWD': '/builds/slave/test', 07:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:33 INFO - 'SHELL': '/bin/bash', 07:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:33 INFO - 'USER': 'cltbld', 07:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:33 INFO - 'XPC_FLAGS': '0x0', 07:32:33 INFO - 'XPC_SERVICE_NAME': '0', 07:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:34 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 07:32:34 INFO - Cleaning up... 07:32:34 INFO - Return code: 0 07:32:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32:34 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')]} 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:34 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')]} 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:34 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:34 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 07:32:34 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 07:32:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:34 INFO - 'HOME': '/Users/cltbld', 07:32:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:34 INFO - 'LOGNAME': 'cltbld', 07:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:34 INFO - 'MOZ_NO_REMOTE': '1', 07:32:34 INFO - 'NO_EM_RESTART': '1', 07:32:34 INFO - 'PAGER': '/bin/cat', 07:32:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:34 INFO - 'PWD': '/builds/slave/test', 07:32:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:34 INFO - 'SHELL': '/bin/bash', 07:32:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:34 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:34 INFO - 'USER': 'cltbld', 07:32:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:34 INFO - 'XPC_FLAGS': '0x0', 07:32:34 INFO - 'XPC_SERVICE_NAME': '0', 07:32:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:34 INFO - Downloading/unpacking psutil>=3.1.1 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:38 INFO - Installing collected packages: psutil 07:32:38 INFO - Running setup.py install for psutil 07:32:38 INFO - building 'psutil._psutil_osx' extension 07:32:38 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 07:32:38 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 07:32:38 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 07:32:38 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 07:32:38 INFO - building 'psutil._psutil_posix' extension 07:32:38 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 07:32:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:32:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:32:38 INFO - ^ 07:32:38 INFO - 1 warning generated. 07:32:38 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 07:32:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:39 INFO - Successfully installed psutil 07:32:39 INFO - Cleaning up... 07:32:39 INFO - Return code: 0 07:32:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:39 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:39 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 07:32:39 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 07:32:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:39 INFO - 'HOME': '/Users/cltbld', 07:32:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:39 INFO - 'LOGNAME': 'cltbld', 07:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:39 INFO - 'MOZ_NO_REMOTE': '1', 07:32:39 INFO - 'NO_EM_RESTART': '1', 07:32:39 INFO - 'PAGER': '/bin/cat', 07:32:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:39 INFO - 'PWD': '/builds/slave/test', 07:32:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:39 INFO - 'SHELL': '/bin/bash', 07:32:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:39 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:39 INFO - 'USER': 'cltbld', 07:32:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:39 INFO - 'XPC_FLAGS': '0x0', 07:32:39 INFO - 'XPC_SERVICE_NAME': '0', 07:32:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32:39 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 07:32:39 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 07:32:39 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 07:32:39 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 07:32:39 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 07:32:39 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 07:32:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:42 INFO - Installing collected packages: mozsystemmonitor 07:32:42 INFO - Running setup.py install for mozsystemmonitor 07:32:42 INFO - Successfully installed mozsystemmonitor 07:32:42 INFO - Cleaning up... 07:32:42 INFO - Return code: 0 07:32:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32:42 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')]} 07:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:42 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')]} 07:32:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:42 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:42 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 07:32:42 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 07:32:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:42 INFO - 'HOME': '/Users/cltbld', 07:32:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:42 INFO - 'LOGNAME': 'cltbld', 07:32:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:42 INFO - 'MOZ_NO_REMOTE': '1', 07:32:42 INFO - 'NO_EM_RESTART': '1', 07:32:42 INFO - 'PAGER': '/bin/cat', 07:32:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:42 INFO - 'PWD': '/builds/slave/test', 07:32:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:42 INFO - 'SHELL': '/bin/bash', 07:32:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:42 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:42 INFO - 'USER': 'cltbld', 07:32:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:42 INFO - 'XPC_FLAGS': '0x0', 07:32:42 INFO - 'XPC_SERVICE_NAME': '0', 07:32:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:42 INFO - Downloading/unpacking jsonschema==2.5.1 07:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 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 07:32:45 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:45 INFO - warning: no files found matching '*.txt' 07:32:45 INFO - no previously-included directories found matching 'build' 07:32:45 INFO - no previously-included directories found matching 'dist' 07:32:45 INFO - no previously-included directories found matching '.git*' 07:32:45 INFO - Installing collected packages: jsonschema, functools32 07:32:45 INFO - Running setup.py install for functools32 07:32:45 INFO - warning: no files found matching '*.txt' 07:32:45 INFO - no previously-included directories found matching 'build' 07:32:45 INFO - no previously-included directories found matching 'dist' 07:32:45 INFO - no previously-included directories found matching '.git*' 07:32:45 INFO - Successfully installed jsonschema functools32 07:32:45 INFO - Cleaning up... 07:32:45 INFO - Return code: 0 07:32:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:45 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:45 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 07:32:45 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 07:32:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:45 INFO - 'HOME': '/Users/cltbld', 07:32:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:45 INFO - 'LOGNAME': 'cltbld', 07:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:45 INFO - 'MOZ_NO_REMOTE': '1', 07:32:45 INFO - 'NO_EM_RESTART': '1', 07:32:45 INFO - 'PAGER': '/bin/cat', 07:32:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:45 INFO - 'PWD': '/builds/slave/test', 07:32:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:45 INFO - 'SHELL': '/bin/bash', 07:32:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:45 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:45 INFO - 'USER': 'cltbld', 07:32:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:45 INFO - 'XPC_FLAGS': '0x0', 07:32:45 INFO - 'XPC_SERVICE_NAME': '0', 07:32:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:46 INFO - Cleaning up... 07:32:46 INFO - Return code: 0 07:32:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:46 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:46 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 07:32:46 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 07:32:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:46 INFO - 'HOME': '/Users/cltbld', 07:32:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:46 INFO - 'LOGNAME': 'cltbld', 07:32:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:46 INFO - 'MOZ_NO_REMOTE': '1', 07:32:46 INFO - 'NO_EM_RESTART': '1', 07:32:46 INFO - 'PAGER': '/bin/cat', 07:32:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:46 INFO - 'PWD': '/builds/slave/test', 07:32:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:46 INFO - 'SHELL': '/bin/bash', 07:32:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:46 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:46 INFO - 'USER': 'cltbld', 07:32:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:46 INFO - 'XPC_FLAGS': '0x0', 07:32:46 INFO - 'XPC_SERVICE_NAME': '0', 07:32:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:32:46 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 07:32:46 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 07:32:46 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 07:32:46 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 07:32:46 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 07:32:46 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 07:32:49 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:50 INFO - Downloading docopt-0.6.1.tar.gz 07:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:50 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:50 INFO - Running setup.py install for blobuploader 07:32:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:50 INFO - Running setup.py install for requests 07:32:51 INFO - Running setup.py install for docopt 07:32:51 INFO - Successfully installed blobuploader requests docopt 07:32:51 INFO - Cleaning up... 07:32:51 INFO - Return code: 0 07:32:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:51 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')]} 07:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:51 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')]} 07:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:51 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:51 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 07:32:51 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 07:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:51 INFO - 'HOME': '/Users/cltbld', 07:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:51 INFO - 'LOGNAME': 'cltbld', 07:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:51 INFO - 'MOZ_NO_REMOTE': '1', 07:32:51 INFO - 'NO_EM_RESTART': '1', 07:32:51 INFO - 'PAGER': '/bin/cat', 07:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:51 INFO - 'PWD': '/builds/slave/test', 07:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:51 INFO - 'SHELL': '/bin/bash', 07:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:51 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:51 INFO - 'USER': 'cltbld', 07:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:51 INFO - 'XPC_FLAGS': '0x0', 07:32:51 INFO - 'XPC_SERVICE_NAME': '0', 07:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-16iz19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Ec78fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1L5u1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-_0L_ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:51 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-XVryyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-iLdfPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-4vq4GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-1aJCkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-VUCU3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-oCgQdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-KwvgLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-jO6Obh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-GoyhIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:52 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-Aq5nfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-r5ryoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-3l0lma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:53 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-MLyneE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:53 INFO - Running setup.py install for manifestparser 07:32:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:53 INFO - Running setup.py install for mozcrash 07:32:53 INFO - Running setup.py install for mozdebug 07:32:53 INFO - Running setup.py install for mozdevice 07:32:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:53 INFO - Running setup.py install for mozfile 07:32:54 INFO - Running setup.py install for mozhttpd 07:32:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Running setup.py install for mozinfo 07:32:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Running setup.py install for mozInstall 07:32:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Running setup.py install for mozleak 07:32:54 INFO - Running setup.py install for mozlog 07:32:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Running setup.py install for moznetwork 07:32:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:54 INFO - Running setup.py install for mozprocess 07:32:55 INFO - Running setup.py install for mozprofile 07:32:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:55 INFO - Running setup.py install for mozrunner 07:32:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:55 INFO - Running setup.py install for mozscreenshot 07:32:55 INFO - Running setup.py install for moztest 07:32:55 INFO - Running setup.py install for mozversion 07:32:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:55 INFO - Cleaning up... 07:32:55 INFO - Return code: 0 07:32:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:55 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')]} 07:32:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:55 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')]} 07:32:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:55 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:32:55 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 07:32:55 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 07:32:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:32:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:32:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:32:55 INFO - 'HOME': '/Users/cltbld', 07:32:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:32:55 INFO - 'LOGNAME': 'cltbld', 07:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:55 INFO - 'MOZ_NO_REMOTE': '1', 07:32:55 INFO - 'NO_EM_RESTART': '1', 07:32:55 INFO - 'PAGER': '/bin/cat', 07:32:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:55 INFO - 'PWD': '/builds/slave/test', 07:32:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:32:55 INFO - 'SHELL': '/bin/bash', 07:32:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:32:55 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:32:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:32:55 INFO - 'USER': 'cltbld', 07:32:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:32:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:55 INFO - 'XPC_FLAGS': '0x0', 07:32:55 INFO - 'XPC_SERVICE_NAME': '0', 07:32:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-LFTnQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:56 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)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-7SE4z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:56 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)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dup0JP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:56 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)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-L1ivOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-MMlMcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:56 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)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-qL88ks-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:56 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)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-5OnKyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:56 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)) 07:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:56 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-dpVaas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-v7eExm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-sybbEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-pm9LJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-HonkIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-fINYhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-ZnCEi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-sTWQcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:57 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)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-i6gQSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:32:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:57 INFO - Running setup.py (path:/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/pip-s7Qyzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:58 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)) 07:32:58 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)) 07:32:58 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)) 07:32:58 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)) 07:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:58 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 07:32:58 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 07:32:58 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 07:32:58 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 07:32:58 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 07:32:58 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 07:33:00 INFO - Downloading blessings-1.6.tar.gz 07:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:33:00 INFO - Installing collected packages: blessings 07:33:00 INFO - Running setup.py install for blessings 07:33:00 INFO - Successfully installed blessings 07:33:00 INFO - Cleaning up... 07:33:00 INFO - Return code: 0 07:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:01 INFO - Reading from file tmpfile_stdout 07:33:01 INFO - Current package versions: 07:33:01 INFO - blessings == 1.6 07:33:01 INFO - blobuploader == 1.2.4 07:33:01 INFO - docopt == 0.6.1 07:33:01 INFO - functools32 == 3.2.3-2 07:33:01 INFO - jsonschema == 2.5.1 07:33:01 INFO - manifestparser == 1.1 07:33:01 INFO - mozInstall == 1.12 07:33:01 INFO - mozcrash == 1.0 07:33:01 INFO - mozdebug == 0.1 07:33:01 INFO - mozdevice == 0.48 07:33:01 INFO - mozfile == 1.2 07:33:01 INFO - mozhttpd == 0.7 07:33:01 INFO - mozinfo == 0.9 07:33:01 INFO - mozleak == 0.1 07:33:01 INFO - mozlog == 3.4 07:33:01 INFO - moznetwork == 0.27 07:33:01 INFO - mozprocess == 0.23 07:33:01 INFO - mozprofile == 0.28 07:33:01 INFO - mozrunner == 6.13 07:33:01 INFO - mozscreenshot == 0.1 07:33:01 INFO - mozsystemmonitor == 0.3 07:33:01 INFO - moztest == 0.7 07:33:01 INFO - mozversion == 1.4 07:33:01 INFO - psutil == 3.1.1 07:33:01 INFO - requests == 1.2.3 07:33:01 INFO - wsgiref == 0.1.2 07:33:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 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 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:33:01 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 07:33:01 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 07:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:01 INFO - 'HOME': '/Users/cltbld', 07:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:01 INFO - 'LOGNAME': 'cltbld', 07:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:01 INFO - 'MOZ_NO_REMOTE': '1', 07:33:01 INFO - 'NO_EM_RESTART': '1', 07:33:01 INFO - 'PAGER': '/bin/cat', 07:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:01 INFO - 'PWD': '/builds/slave/test', 07:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:01 INFO - 'SHELL': '/bin/bash', 07:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:33:01 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:01 INFO - 'USER': 'cltbld', 07:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:01 INFO - 'XPC_FLAGS': '0x0', 07:33:01 INFO - 'XPC_SERVICE_NAME': '0', 07:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 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)) 07:33:01 INFO - Cleaning up... 07:33:01 INFO - Return code: 0 07:33:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:33:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:33:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e2bc490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e232570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231cecf90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, '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.PeGmouhOfR/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.F8wd67ZidR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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 07:33:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:33:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:33:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:01 INFO - 'HOME': '/Users/cltbld', 07:33:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:01 INFO - 'LOGNAME': 'cltbld', 07:33:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:01 INFO - 'MOZ_NO_REMOTE': '1', 07:33:01 INFO - 'NO_EM_RESTART': '1', 07:33:01 INFO - 'PAGER': '/bin/cat', 07:33:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:01 INFO - 'PWD': '/builds/slave/test', 07:33:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:01 INFO - 'SHELL': '/bin/bash', 07:33:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:33:01 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:33:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:01 INFO - 'USER': 'cltbld', 07:33:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:01 INFO - 'XPC_FLAGS': '0x0', 07:33:01 INFO - 'XPC_SERVICE_NAME': '0', 07:33:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:33:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:33:01 INFO - Cleaning up... 07:33:01 INFO - Return code: 0 07:33:01 INFO - Running post-action listener: _resource_record_post_action 07:33:01 INFO - Running post-action listener: _start_resource_monitoring 07:33:01 INFO - Starting resource monitoring. 07:33:01 INFO - [mozharness: 2016-12-07 15:33:01.760859Z] Finished create-virtualenv step (success) 07:33:01 INFO - [mozharness: 2016-12-07 15:33:01.761951Z] Running install step. 07:33:01 INFO - Running pre-action listener: _resource_record_pre_action 07:33:01 INFO - Running main action method: install 07:33:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:33:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:33:02 INFO - Reading from file tmpfile_stdout 07:33:02 INFO - Detecting whether we're running mozinstall >=1.0... 07:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:33:02 INFO - Reading from file tmpfile_stdout 07:33:02 INFO - Output received: 07:33:02 INFO - Usage: mozinstall [options] installer 07:33:02 INFO - Options: 07:33:02 INFO - -h, --help show this help message and exit 07:33:02 INFO - -d DEST, --destination=DEST 07:33:02 INFO - Directory to install application into. [default: 07:33:02 INFO - "/builds/slave/test"] 07:33:02 INFO - --app=APP Application being installed. [default: firefox] 07:33:02 INFO - mkdir: /builds/slave/test/build/application 07:33:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 07:33:33 INFO - Reading from file tmpfile_stdout 07:33:33 INFO - Output received: 07:33:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:33:33 INFO - Running post-action listener: _resource_record_post_action 07:33:33 INFO - [mozharness: 2016-12-07 15:33:33.157478Z] Finished install step (success) 07:33:33 INFO - [mozharness: 2016-12-07 15:33:33.157657Z] Running run-tests step. 07:33:33 INFO - Running pre-action listener: _resource_record_pre_action 07:33:33 INFO - Running main action method: run_tests 07:33:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:33:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:33:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:33:33 INFO - 2016-12-07 07:33:33.172 screenresolution[2245:283559] starting screenresolution argv=screenresolution get 07:33:33 INFO - 2016-12-07 07:33:33.175 screenresolution[2245:283559] Display 0: 1600x1200x32@60 07:33:33 INFO - 2016-12-07 07:33:33.180 screenresolution[2246:283561] starting screenresolution argv=screenresolution list 07:33:33 INFO - Available Modes on Display 0 07:33:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:33:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:33:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:33:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:33:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:33:33 INFO - Intel Iris: 07:33:33 INFO - Chipset Model: Intel Iris 07:33:33 INFO - Type: GPU 07:33:33 INFO - Bus: Built-In 07:33:33 INFO - VRAM (Dynamic, Max): 1536 MB 07:33:33 INFO - Vendor: Intel (0x8086) 07:33:33 INFO - Device ID: 0x0a2e 07:33:33 INFO - Revision ID: 0x0009 07:33:33 INFO - Displays: 07:33:33 INFO - Display: 07:33:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:33:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:33:33 INFO - Display Serial Number: 1600x1200 60 07:33:33 INFO - Main Display: Yes 07:33:33 INFO - Mirror: Off 07:33:33 INFO - Online: Yes 07:33:33 INFO - Rotation: Supported 07:33:33 INFO - Return code: 0 07:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:33 INFO - Python 2.7.3 07:33:33 INFO - Return code: 0 07:33:33 INFO - grabbing minidump binary from tooltool 07:33:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0d0d30>, '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 0x10df36db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e0c8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:33:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:33:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:33:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:33 INFO - Return code: 0 07:33:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:33:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:33:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:33:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PeGmouhOfR/Render', 07:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:33:33 INFO - 'HOME': '/Users/cltbld', 07:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:33:33 INFO - 'LOGNAME': 'cltbld', 07:33:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:33 INFO - 'MOZ_NO_REMOTE': '1', 07:33:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:33 INFO - 'NO_EM_RESTART': '1', 07:33:33 INFO - 'PAGER': '/bin/cat', 07:33:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:33 INFO - 'PWD': '/builds/slave/test', 07:33:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:33:33 INFO - 'SHELL': '/bin/bash', 07:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.F8wd67ZidR/Listeners', 07:33:33 INFO - 'TMPDIR': '/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/', 07:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:33:33 INFO - 'USER': 'cltbld', 07:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:33 INFO - 'XPC_FLAGS': '0x0', 07:33:33 INFO - 'XPC_SERVICE_NAME': '0', 07:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:33:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:33:33 INFO - mozversion application_buildid: 20161207062538 07:33:33 INFO - mozversion application_changeset: 93266100e27057f116effff38f70d8563533097b 07:33:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:33:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:33 INFO - mozversion application_name: Firefox 07:33:33 INFO - mozversion application_remotingname: firefox-dev 07:33:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:33 INFO - mozversion application_vendor: Mozilla 07:33:33 INFO - mozversion application_version: 52.0a2 07:33:33 INFO - mozversion platform_buildid: 20161207062538 07:33:33 INFO - mozversion platform_changeset: 93266100e27057f116effff38f70d8563533097b 07:33:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:33:33 INFO - mozversion platform_version: 52.0a2 07:33:33 INFO - using testdate: 1481124813 07:33:33 INFO - actual date: 1481124813 07:33:33 INFO - starting webserver on 'localhost:49496' 07:33:33 INFO - SUITE-START | Running 2 tests 07:33:33 INFO - TEST-START | dromaeo_css 07:33:33 INFO - operating with platform_type : mac_ 07:33:33 INFO - Initialising browser for dromaeo_css test... 07:33:33 INFO - TEST-INFO | started process 2256 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpExDOMy/profile http://localhost:49496/getInfo.html) 07:33:37 INFO - PROCESS | 2256 | 2016-12-07 07:33:37.011 plugin-container[2258:283738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d43, name = 'com.apple.tsm.portname' 07:33:37 INFO - PROCESS | 2256 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:37 INFO - PROCESS | 2256 | 2016-12-07 07:33:37.016 plugin-container[2258:283738] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 07:33:37 INFO - PROCESS | 2256 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:37 INFO - PROCESS | 2256 | 2016-12-07 07:33:37.016 plugin-container[2258:283738] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:37 INFO - PROCESS | 2256 | __metrics Screen width/height:1600/1200 07:33:37 INFO - PROCESS | 2256 | colorDepth:24 07:33:37 INFO - PROCESS | 2256 | Browser inner width/height: 1024/689 07:33:37 INFO - PROCESS | 2256 | __metrics 07:33:37 ERROR - PROCESS | 2256 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:33:38 INFO - TEST-INFO | 2256: exit 0 07:33:38 INFO - Browser initialized. 07:33:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:38 INFO - TEST-INFO | started process 2259 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpExDOMy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:40 INFO - PROCESS | 2259 | 2016-12-07 07:33:40.644 plugin-container[2260:283871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 07:33:40 INFO - PROCESS | 2259 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:40 INFO - PROCESS | 2259 | 2016-12-07 07:33:40.646 plugin-container[2260:283871] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4723, name = 'com.apple.CFPasteboardClient' 07:33:40 INFO - PROCESS | 2259 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:33:40 INFO - PROCESS | 2259 | 2016-12-07 07:33:40.647 plugin-container[2260:283871] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:33:50 INFO - PROCESS | 2259 | RSS: Main: 229675008 07:33:50 INFO - PROCESS | 2259 | 07:34:39 INFO - PROCESS | 2259 | 1481124879967 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:36:54 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49496/tests/dromaeo/cssquery-ext.html) 07:36:56 INFO - PROCESS | 2259 | RSS: Main: 232382464 07:36:56 INFO - PROCESS | 2259 | 07:39:58 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-ext.html (next: http://localhost:49496/tests/dromaeo/cssquery-jquery.html) 07:39:59 INFO - PROCESS | 2259 | RSS: Main: 243290112 07:39:59 INFO - PROCESS | 2259 | 07:43:01 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49496/tests/dromaeo/cssquery-mootools.html) 07:43:01 INFO - PROCESS | 2259 | RSS: Main: 246272000 07:43:01 INFO - PROCESS | 2259 | 07:46:03 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49496/tests/dromaeo/cssquery-prototype.html) 07:46:04 INFO - PROCESS | 2259 | RSS: Main: 245514240 07:46:04 INFO - PROCESS | 2259 | 07:49:07 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49496/tests/dromaeo/cssquery-yui.html) 07:49:07 INFO - PROCESS | 2259 | RSS: Main: 249094144 07:49:07 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | Cycle 1(1): loaded http://localhost:49496/tests/dromaeo/cssquery-yui.html (next: http://localhost:49496/tests/dromaeo/cssquery-dojo.html) 07:52:10 INFO - PROCESS | 2259 | RSS: Main: 250699776 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | __start_tp_report 07:52:10 INFO - PROCESS | 2259 | _x_x_mozilla_page_load 07:52:10 INFO - PROCESS | 2259 | _x_x_mozilla_page_load_details 07:52:10 INFO - PROCESS | 2259 | |i|pagename|runs| 07:52:10 INFO - PROCESS | 2259 | |0;dojo.html;3370.1574606348413;3385.8137802420865;3400.353932752777;3415.214500664847;3487.250241198142;5676.829695109148;5739.368669446358;5758.827235182941;5765.13522971554;5802.216700745398;5666.376698563155;5700.686462244575;5761.020626493496;5773.971130144343;5785.768569257235;5228.843134705965;5251.264822924774;5253.238280449342;5271.15661494161;5287.814926477574;5303.204519322094;5315.867103322409;5339.06566350889;5344.171653393731;5360.812371566996;5164.561012313939;5178.171492561191;5292.311999440068;5294.41761406245;5298.205269209611;5204.583633309327;5221.86945326368;5260.053190425722;5302.151655735064;5355.3305836770405;5183;5221.71280579568;5246.081935661244;5248.265242866002;5289.710140601206;5578.135389014709;5739.827805165852;5747.626404283708;5831.970840145815;5881.67650779207;5040;6111.227117700271;6162.630242185438;6166.044263139221;6193.3496982816605;6213.596116252429;6214.844628884314;6236.126942228092;6248.96875515624;6255.96872015637;5882.117682347682;5930.822075337746;5938.435848594377;5942.2275104236605;5986.46121849027;6148.800983808114;6200.534959878028;6200.906986395207;6212.161358216583;6219.253689557282;6180.598261113013;6187.907181392283;6214.906776398358;6217.502599792006;6227.813165605039;6162.815115546541;6222.719977601018;6226.719797609118;6228.377162283826;6244.75020999164;5139;6069.2110025696375;6075.27096748393;6154.076888466676;6194.163787888578;6189.50483961282;6218.22272215973;6230.06549017651;6231;6236.158118653923;4886.315915771795;4915.557599816034;4916.901661966812;4952.405711314594;4956.107900577858;4388.890277743082;4397.912041759211;4408.448943882015;4411.117776444724;4423.358613001097;4865.5864251538305;5836.270466191726;5847.532197424196;5923.378045305181;5990.820275391745;6164.907526387108;6214.036824292242;6214.8135555933395;6227.252729672468;6247.125402443661;5571.721413929287;5732.656040637492;5765.250517432707;5795.1886735857015;5831.912521312183;5273.736313184402;5279.551238144801;5292;5305.442928492453;5312.256284120226;6380.170577824946;6422.967885160544;6434.453071488976;6436.967815160894;6487;4422.668299877458;6203.31763506005;6253.249610046823;6257.749690012349;6273.874522509433;6279.96860015697;6289.465395441439;6333.96833015832;6336.809895703136;6454.870902582016;6151.169592105009;6179.536534760001;6195.845103872439;6216.316205217513;6227.878981783322;6160.075988601746;6203.565750397609;6248.875022499434;6251.4061164189325;6260.561760676709;5891.440313170242;5966.492848107786;6061.969690151521;6077.544184186116;6123.724432400463;6029.849253768691;6100.450959413674;6102.908456373069;6131.63210207389;6132.9080063799975;5707.372189059117;6033.939660603338;6057.757689692363;6107.633541987495;6130.448259656652;6173.783917563043;6174.44430001302;6186.81439556814;6227.564070515021;6247.3440288769025;4955.0337684151245;5865.501432378125;5884.029135192645;6076.989187136469;6088.6042407243385 07:52:10 INFO - PROCESS | 2259 | |1;ext.html;468.4308565093413;476.6234674607061;506.46061944029606;530.8619758862696;550.6668465578325;37783.81108094459;39219.80390098049;39413.40879886804;39466.21067578647;39499.605003950026;30383.696163038363;34735.78424755134;39490;39805;39987.60012399875;7722.613869306526;9419.52902354883;9424.434533927952;9425.293103017268;9426.811463770755;9408.529573521297;9445.386049906769;9505.19205867502;9515.381500202464;9543.904560954406;9422.387544809566;9475.668351607696;9491.098345657152;9522.952385238064;9536.809263814754;9480.09939055792;9501.572429240701;9509.286803489731;9512.38169518979;9540.33217674763;8009.839803203961;9266.166045055978;9346.532673366373;9386.95306523463;9389.295802814817;38648.61351386478;38915.805420972996;38977.41533876994;39166.41250381246;39284.41073383902;3263.2005158736024;3283.8850640227715;3702.185519185775;3813.9427908581392;3880.185161116169;27737;27900.16299511018;28569.857150714113;29653.473967014146;29909.40181196364;3024.6370435547874;3172.936541269185;3224.5163225516126;3229.40256052631;3299.224682199681;367731;373878;374930.250697495;375628;375883;57077.71461142668;57283.713581431824;57328.71335643295;57419.712901435225;57517.712411438515;58031.41968580345;58544.414555854746;58628.827423451294;58682.41317586855;58864.41135588675;15396.923015384851;15680.607984800472;15710.842891571167;15718.371265149495;15742.685146297239;11965.581204657796;12133;12134.5146194153;12181.817272740916;12192.390380481118;12388.256704597752;14480.85519144795;14806.777898331533;14911.850881491046;15027.924860375628;3145.937081258362;3239.093053944899;3268.4607039838634;6565.770198043141;6764.864702706017;873.3580818098692;943.7168849345169;954.9781733545041;1021.8518314844306;1022.943738094412;25385.238442846374;29161.56257656137;29772.2556936074;29966.55050174249;30326.241843954078;989.6585677941099;1076.967690969272;1109.683740134074;1120.4229821641861;1151.3034614058543;14796.852031479762;14832.925835370754;15223.010504317184;15318.846811531965;15445.382184712711;604732;661668;662843;669155.6542217258;670027.6498617475;55369.72315138399;55876.44123558794;55888.16167757487;55919.440805591425;56281.718591407596;1344.9932750336186;1355.898307626932;1377.9104358216684;1386.3692020130816;1386.729587730383;28778;29420.411591768472;29425.411491770472;29640.258993524472;30226.24434389158;46909.3581724638;47949.280760787915;47997.520024799305;48033.75983120202;48086.759566201945;453414;556128;558952;574062;602914.98542507;25316.493670126863;25495.10767123216;25542.616860747476;25672.61491077598;25729.485410292065;35587.644123558435;44614.10771784481;45632.77183614061;45825.77087114543;46039.76980115078;37204.44193337048;37599.43600846044;37761.81119094387;38129.80935095418;39114.4132838002;37490;38265;38325.40191646918;38637.80681096577;38853.805730971166;35710.64289357177;36322.09194770152;36952.63047369492;37158.07104822401;37603;27682.584761228194;29865.402691946474;32276.67723322737;33909.152271193416;33931.660683393835;25172.83165799174;25320.620190696787;25340.74659253384;25651.743482564936;25833.48333033291 07:52:10 INFO - PROCESS | 2259 | |2;jquery.html;359.9766015209012;363.42034455044194;370.8460988689693;378.5117198813531;390.82751744765704;18321.816781832178;18819.52951176221;19675.212991480323;19984.60030799385;20139.496512587193;19599.706004409945;19807.207711691513;19909.40271791845;20287.59424811503;20326.288579899705;5608.971955140219;5675.51758100562;5928.466438020578;5956.16613674086;5979.073243647242;5693.316801983768;5892.528597712194;5894.88210235795;5896.321922978869;5900.675462849542;5571.415001424853;5771.538276937856;5836.270466191726;5852.795152169675;5855.79504717335;5777.913331300034;5826.388229235911;5840.386759390267;5856.736446859902;5862.941370586283;5078.136716758123;5144.382674079097;5167.715775632339;5367.758450869681;5435.891282174374;12600.936995314965;12863.42114604845;12866.97064234859;13574.728505429935;23344.64983025256;2133.445304220914;2200.8239340852692;2218.889055547232;2231.921882734113;2453.6810214671978;8446.155384461566;9607.855882161773;9756.121949024551;10177.592896284139;11180.608678696288;1761.6652835961254;1774.2814160265114;1816.6275913437714;1822.298415110179;1849.2602958816447;107747.46126269396;118435.40782296119;118876;118919.81080189174;119511;9423.623055077856;11416.885831141748;11542.711432214262;11643.941780291045;11819.231749936227;14432;14438.133711977314;14438.639034024234;14451.638709032148;14456;8007.07918589358;8269.131741167092;8297.917020829715;8408.831823363498;8415.873761893576;8060.677572897019;8072.152423995513;8146.063202731643;8214.35712857431;8281.8343633127;4395.208862404797;4447.777611119496;4449.1546606145375;4451.5325890781005;4519.389882365838;1633.9264733087039;1859.869809113349;1923.5864289177894;1924.28801343501;1925.0182406972544;711.697528550364;754.984545785917;879.1911441473859;889.3952112563389;926.8331700294012;20169;21155.47111322229;21211.15155393767;21400.464988375104;21443.356699299045;748.3713680508399;887.3965703321803;921.8154671247415;957.0764212534938;972.8832540095092;9071.729957805912;10767.97704218098;10882.891171088346;10961.232713709964;11068.225224234387;602230;606632;612291;620739;628375;116445;123606;123867;123879;139216;965.2856885904521;997.4015590645699;1008.294194064158;1008.3395376028712;1011.1304278320638;14594.982507550041;18558.81441185571;19318.03409829531;19328.71006934869;19455.3190638327;53233.4676653244;53500.732496338824;54669.1799622998;56486.15270770859;56791.71604141953;76828.84756728541;79850.6007469959;80152;80519.19480805116;81400;7713;7809.882851757115;7976.7208147714555;8062.274395304451;8129.065157506962;11546.42267886619;12274.4476498556;12533.182688510296;12543.686407839878;12670.556530521388;8918.464892106495;10549.841752373566;10564.577416903545;10843.024127828534;10976.506057227285;10652.041316281571;10680.465976700978;10803.675889723321;10972.615958441416;11018.50416731233;9325.160735533835;10976.176786740867;11107;11346.319220846446;11370.829437558277;7804.141544429995;7946.562939038177;8047.623087017891;8061.153578874134;8160.18398160203;10558.736031599272;10782.892171078189;10871.021608055313;11027;11054.22620416563 07:52:10 INFO - PROCESS | 2259 | |3;mootools.html;1287.388490467028;1445.2918070145624;1526.9616660670747;1671.9916400417987;1693.618935739458;7510.586917719524;7778.222177782219;8177.264046235838;8545.658173673046;8567.228949394554;7985.241402066809;8312.8753068704;8316.501009939408;8452.535110568917;8463.957680211606;2262.5814224368546;2306.3888069661552;2309.58427483053;2310.8844557772127;2324.7094113235844;2303.7581053989343;2337.9298621041394;2355.587772139869;2362.527494501098;2362.8582285062867;2295.0590257994227;2299.356180269527;2317.44381348476;2319.1071437496516;2321.3384185507134;2278.464560828204;2284.611616025263;2286.931392058241;2306.538692261546;2310.7573704760925;2306.550222706573;2326.360250930991;2329.6621989811383;2331.3355693627236;2338.637511185752;8405.537695426749;8449.704260350858;8465.449745766568;8482.915170848275;8483.957580212122;5024.899502009976;5193.454687257859;5197;5207.479252074762;5216.400113986902;3192.4732419151046;3380.6112297085906;3396.557797546092;3522.8943131705832;3533.9044896082296;988.6687959533565;1050.5482642463737;1053.9473026348728;1066.0831684751108;1080.783843231349;10857.945710271399;10917.39954302513;10939.99999999992;10950.835737463865;10985.945070274678;3937.9606203938165;4462.9107417851465;4554.863354099382;4682.204025315705;4714.764261786897;9388.8591671125;9426.764330891783;9463.432194068379;9515.429074255568;9571.28215383849;4444.73331600105;4576.604135738565;5149.665271757323;5161.174212126042;5181.53366197044;4059.736117152435;4268.829246830154;4389.824407023747;4607.976960115178;4747.667663263607;3789.829457674411;3819;3839.9424008639894;3908.022994251437;3955.3869150281753;1254.3602762591145;1271.3261971155118;1281.4681907008487;1285.7107150890974;1295.164618820874;751.0049184830121;852.4586887326592;857.7469646454311;867.0116067682847;871.0940621753432;5240.895182096413;5246.317978662826;5322.148456246982;5550.639208451518;5572.0527510323345;428.53289913993274;429.21239525470486;432.95873424414333;438.8939871523806;442.0650324563525;3515.82420878955;3517.736169787276;3553.680168784822;3555.377808883487;3627.582827974764;9838.3113182078;10072.848907266396;10207.846882296772;10216.489175541343;10231.28381013322;9508.667196648084;10083.747906302402;10085.949570252102;10100.444475553768;10118.494075296207;7307.744228951961;7622.2758837910305;7635.312821846061;7658.770236892902;7663.655135518915;5543;5568;5593.972030139823;5702.401247868914;5713.085906254979;9338.626454941726;9384.67153649619;9425.293103017439;9480.810383792423;9559.235261179228;9607.903920960702;9641.903580964381;9656.32405731592;9680.419174849532;9748.025197480196;6922.826929326807;7115.324044215791;7133.678984445816;7215.278472152742;7279.4540409470565;8014.719484818003;8030.076541197837;8071.798205044921;8072.677092916218;8097.757067287991;7027.297270272932;7064.540804847668;7239.8914016290855;7295.8540829184185;7320.560766353823;6887.758928437481;7086.185088714864;7122.109736282965;7197.46019048563;7263.201047884834;6608.603483790988;6658.733650654113;6742.08981787472;6770.966145169243;6815.284395138439;4724.244120940633;4732.905341893212;4773.11697335994;4778.235482322812;4783;4654.6741728078705;4691.1555919934735;4714.504976977505;4828.95171048285;4920.040592084509 07:52:10 INFO - PROCESS | 2259 | |4;prototype.html;255.8963619734008;295.9526475763877;306.953956906464;310.5853685330084;311.8487533546231;4759.547842954914;4857.1499987502175;4899.305382039873;5240.135377662686;5321.3348331458565;5189.169732842746;5253.8949221015555;5274.4967684210005;5365.4976606550135;5422.8915421691645;4071.796410179494;4094.733842300241;4098.7540747555095;4101.569335219804;4115.403266526352;3731.1977924746175;4021.2761702893467;4115.42384066231;4120.8365608055865;4122;3354.9832250838713;3990.840366385341;3994.5419921728503;3996.680265578747;4007.056577559881;3725.105974566112;3876.6317199865966;3901.4147877818273;3960.6435420811977;4028.939565906514;3464.064702530328;3481.9129521761906;3488.3023395320783;3511.7892926424497;3521.7006554442905;4479.513869802258;4671.3226582145735;4687.015726697397;5045;5168.286649509;3894.2990261752875;4159.521655009652;4351.629236790401;4580.984366878596;4619.769011549442;4679.649026323005;4882.316475693406;5081.568066714333;5570.415106413809;5730.598858079936;3080.907572772798;3802.39161734124;3840.0591854995428;3850.7497012694084;3856.691464682847;4836.951630483685;4946.950530494649;5747.482726554588;5860.589758716891;5937.406259374071;2985.686093277727;3322.401967645847;3717.237966216919;3856.5564960029396;3885.86399476017;3331.000699790102;3751.4056525976353;3922.3135951208424;3938.8774199353047;3972.503437070366;3666.688331491853;4120.7733574653685;4497.955020449819;4533.909321813545;4560.540626999395;4632.884177895579;5147.940823670487;5570.777168913279;5574.024545704486;5755.683437410982;978.5498670611456;1220.365409986802;1242.7700875338091;1258.1947553565726;1270.6315168601186;731.4221764805744;785.7642707187821;811.0348685064754;866.8179682266668;871.0940621753432;4918.508149185053;4964.304997300381;4984.0811287654515;5004.599632029429;5009.599232061426;4932.975335123301;5023.819402440424;5048.844472204872;5467.835964921059;5523.558115350762;4313.094250207429;4632.4672662644225;4782.556559277315;4998.200647766801;5056.115179843513;2812.662480502353;2828.5291648342745;2843.331817023039;2868.9282767930968;2871.6410448693914;4805.807767689324;5516.586256030814;5659.858503537444;5666.0735349981205;5673.631213971079;4749.857504274877;4799.216943582974;4820.4456487504385;5419;5527.861803454945;4859.092316760098;4883.584895283941;4950.638574391999;5632.662040277596;5680.431956804369;4779;5237.952409518188;5454.3454785426;5480.534154596904;5490.945090549043;4502.234620114523;4714.38712967312;4754.500777418321;4911.582515486224;5333.626646134733;5566.276384070045;5582.320486166744;5593.7556217393;5640.887182256414;5694.943050569441;3053.603031605877;3124.6562878083846;3275.8034517929;3454.29187016666;3613.638636136365;4422.579854913778;4426.627745398937;4509.2559727644575;4676.111538807616;4997.807978956674;4634.606058484932;4740.549647783455;5207.92188117171;5514.117741161395;5575.303087114111;4694.2958556216845;5329.520343169133;5581.274434323512;5638.2670252866865;5650.604457687922;4606;4790.353302304145;4958.628102892226;5483.298773327908;5502.449755024466;4170.186813571325;5449.918251226314;5728.742206600797;5730.484256416942;5730.598858079894;4503.166914120898;5205.297284866646;5216.347956505437;5509.201165831012;5630.2680651516675 07:52:10 INFO - PROCESS | 2259 | |5;yui.html;688.0711040095869;691.6921969723473;742.3652776875771;765.5330248548388;785.9017622797151;13727.79408308875;14527;14536.3458644361;14557.490487832927;14597.489087881926;12367.938160309186;12419.441125149368;12425.31660758658;12428.565000224993;12473.126881118325;639.1084437210078;663.0419044480727;780.7540624703229;808.5795386399069;813.9877901831477;806.8749343851713;811.3225456743626;813.6257321632056;816.049302562514;817.9959100204491;871.0331531999476;873.1137895036543;874.2656168818191;876.7238319929234;877.3113106211625;858.9141085891423;861.9784505387353;867.2195024477958;867.41449521573;869.2437579306013;620.9316975132732;641.3650486018854;641.9261784894703;642.9453496452807;645.441692935612;13718.039737218398;14020.29898505081;14033.087849289866;14076.577702668936;14308.28458577067;13776.793348099787;13925.930370348186;13960.720785584333;14051.367688454044;14055.859441405659;9480.383775054599;11114.22200445969;11159.27464714791;11292.943535282353;11344.48949797261;3589.838457269429;3594.6944509716704;3623.2391197848483;3637.781733095996;3647.544056992876;83696;86081;90846.5457672714;91661;94618.05381946231;9519.333646644807;10465.529051192714;10536.367817930948;10828.675139745821;11233.66299011031;21396.893015534824;21627.78372216289;21690.674639880413;21823.563528729654;21837.344879653636;6009.549283803733;7123.2520585338825;7247.746328878464;7298.56208627484;7313.12242530889;4063.2076745034433;4140.585941405896;4168.187203495289;4226.429432026698;4282.721623094489;2804.7055059218897;3190.457622204231;3283.195617073832;3288.605367355885;3288.605367355885;497.93526841510374;506.30888836737586;521.6531006880458;526.3578434310135;527.8205410160564;544.599719206383;592.1768741449389;598.2163365990566;605.306923572507;619.2568917299259;6598.832560371049;7850.214978502104;8219.97250343707;8758.781030474289;9570.138687518018;605.3825098399695;673.9696713647897;682.3244987462376;682.5392859819701;688.6935313785317;4023.637872591481;4419.469663640384;4489.1021795641;4500.422318278903;4570.680052396367;70164;108314.45842770893;108953.71831492377;109502.26244343795;109968.35047474294;82397;89189;91528;93369;98595.50702246443;72548.63725681338;83589;85292;87309;89377.55311223402;8822.691205808023;9329.72010839676;9369.906300936904;9425.151736343762;9438.292128090283;37707;41390;50770.74614626903;54092.72953635207;54995.90008199894;54437.45562544324;57631.42368576428;62920.37079629328;70410.64794675994;70420.64789676019;9397.864076706774;9880.913099559186;11485.598004069818;11680.649580512598;12241.816372754238;11821.408929553316;13012.154209976321;13313.933430333174;13417.926565874512;13432.328383580587;11554.480048397674;11647.88352116468;11760.945669924358;12162.513499460276;12422.37888105573;12284.262944223376;12504.624861253813;12542.623721288375;12548.811767823672;12766.234025958473;11853.407329633656;12048.75902481963;12053;12149.453274602487;12610.49558017669;8297.83404331922;10106.89893101089;10147.086762191439;10351.844722329322;10429.26995110335;8766.254868336262;9232.95383523078;10249.487525623837;10255.025772551595;10279.94860025695 07:52:10 INFO - PROCESS | 2259 | __end_tp_report 07:52:10 INFO - PROCESS | 2259 | __start_cc_report 07:52:10 INFO - PROCESS | 2259 | _x_x_mozilla_cycle_collect,378 07:52:10 INFO - PROCESS | 2259 | __end_cc_report 07:52:10 INFO - PROCESS | 2259 | __startTimestamp1481125930701__endTimestamp 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | ------- Summary: start ------- 07:52:10 INFO - PROCESS | 2259 | Number of tests: 6 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | [#0] dojo.html Cycles:165 Average:5736.89 Median:5986.46 stddev:647.75 (10.8%) stddev-sans-first:622.56 07:52:10 INFO - PROCESS | 2259 | Values: 3370.2 3385.8 3400.4 3415.2 3487.3 5676.8 5739.4 5758.8 5765.1 5802.2 5666.4 5700.7 5761.0 5774.0 5785.8 5228.8 5251.3 5253.2 5271.2 5287.8 5303.2 5315.9 5339.1 5344.2 5360.8 5164.6 5178.2 5292.3 5294.4 5298.2 5204.6 5221.9 5260.1 5302.2 5355.3 5183.0 5221.7 5246.1 5248.3 5289.7 5578.1 5739.8 5747.6 5832.0 5881.7 5040.0 6111.2 6162.6 6166.0 6193.3 6213.6 6214.8 6236.1 6249.0 6256.0 5882.1 5930.8 5938.4 5942.2 5986.5 6148.8 6200.5 6200.9 6212.2 6219.3 6180.6 6187.9 6214.9 6217.5 6227.8 6162.8 6222.7 6226.7 6228.4 6244.8 5139.0 6069.2 6075.3 6154.1 6194.2 6189.5 6218.2 6230.1 6231.0 6236.2 4886.3 4915.6 4916.9 4952.4 4956.1 4388.9 4397.9 4408.4 4411.1 4423.4 4865.6 5836.3 5847.5 5923.4 5990.8 6164.9 6214.0 6214.8 6227.3 6247.1 5571.7 5732.7 5765.3 5795.2 5831.9 5273.7 5279.6 5292.0 5305.4 5312.3 6380.2 6423.0 6434.5 6437.0 6487.0 4422.7 6203.3 6253.2 6257.7 6273.9 6280.0 6289.5 6334.0 6336.8 6454.9 6151.2 6179.5 6195.8 6216.3 6227.9 6160.1 6203.6 6248.9 6251.4 6260.6 5891.4 5966.5 6062.0 6077.5 6123.7 6029.8 6100.5 6102.9 6131.6 6132.9 5707.4 6033.9 6057.8 6107.6 6130.4 6173.8 6174.4 6186.8 6227.6 6247.3 4955.0 5865.5 5884.0 6077.0 6088.6 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | [#1] ext.html Cycles:180 Average:65453.91 Median:20971.88 stddev:144374.43 (688.4%) stddev-sans-first:144696.99 07:52:10 INFO - PROCESS | 2259 | Values: 468.4 476.6 506.5 530.9 550.7 37783.8 39219.8 39413.4 39466.2 39499.6 30383.7 34735.8 39490.0 39805.0 39987.6 7722.6 9419.5 9424.4 9425.3 9426.8 9408.5 9445.4 9505.2 9515.4 9543.9 9422.4 9475.7 9491.1 9523.0 9536.8 9480.1 9501.6 9509.3 9512.4 9540.3 8009.8 9266.2 9346.5 9387.0 9389.3 38648.6 38915.8 38977.4 39166.4 39284.4 3263.2 3283.9 3702.2 3813.9 3880.2 27737.0 27900.2 28569.9 29653.5 29909.4 3024.6 3172.9 3224.5 3229.4 3299.2 367731.0 373878.0 374930.3 375628.0 375883.0 57077.7 57283.7 57328.7 57419.7 57517.7 58031.4 58544.4 58628.8 58682.4 58864.4 15396.9 15680.6 15710.8 15718.4 15742.7 11965.6 12133.0 12134.5 12181.8 12192.4 12388.3 14480.9 14806.8 14911.9 15027.9 3145.9 3239.1 3268.5 6565.8 6764.9 873.4 943.7 955.0 1021.9 1022.9 25385.2 29161.6 29772.3 29966.6 30326.2 989.7 1077.0 1109.7 1120.4 1151.3 14796.9 14832.9 15223.0 15318.8 15445.4 604732.0 661668.0 662843.0 669155.7 670027.6 55369.7 55876.4 55888.2 55919.4 56281.7 1345.0 1355.9 1377.9 1386.4 1386.7 28778.0 29420.4 29425.4 29640.3 30226.2 46909.4 47949.3 47997.5 48033.8 48086.8 453414.0 556128.0 558952.0 574062.0 602915.0 25316.5 25495.1 25542.6 25672.6 25729.5 35587.6 44614.1 45632.8 45825.8 46039.8 37204.4 37599.4 37761.8 38129.8 39114.4 37490.0 38265.0 38325.4 38637.8 38853.8 35710.6 36322.1 36952.6 37158.1 37603.0 27682.6 29865.4 32276.7 33909.2 33931.7 25172.8 25320.6 25340.7 25651.7 25833.5 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | [#2] jquery.html Cycles:180 Average:35004.23 Median:1406.83 stddev:102382.23 (7277.5%) stddev-sans-first:102636.39 07:52:10 INFO - PROCESS | 2259 | Values: 360.0 363.4 370.8 378.5 390.8 18321.8 18819.5 19675.2 19984.6 20139.5 19599.7 19807.2 19909.4 20287.6 20326.3 5609.0 5675.5 5928.5 5956.2 5979.1 5693.3 5892.5 5894.9 5896.3 5900.7 5571.4 5771.5 5836.3 5852.8 5855.8 5777.9 5826.4 5840.4 5856.7 5862.9 5078.1 5144.4 5167.7 5367.8 5435.9 12600.9 12863.4 12867.0 13574.7 23344.6 2133.4 2200.8 2218.9 2231.9 2453.7 8446.2 9607.9 9756.1 10177.6 11180.6 1761.7 1774.3 1816.6 1822.3 1849.3 107747.5 118435.4 118876.0 118919.8 119511.0 9423.6 11416.9 11542.7 11643.9 11819.2 14432.0 14438.1 14438.6 14451.6 14456.0 8007.1 8269.1 8297.9 8408.8 8415.9 8060.7 8072.2 8146.1 8214.4 8281.8 4395.2 4447.8 4449.2 4451.5 4519.4 1633.9 1859.9 1923.6 1924.3 1925.0 711.7 755.0 879.2 889.4 926.8 20169.0 21155.5 21211.2 21400.5 21443.4 748.4 887.4 921.8 957.1 972.9 9071.7 10768.0 10882.9 10961.2 11068.2 602230.0 606632.0 612291.0 620739.0 628375.0 116445.0 123606.0 123867.0 123879.0 139216.0 965.3 997.4 1008.3 1008.3 1011.1 14595.0 18558.8 19318.0 19328.7 19455.3 53233.5 53500.7 54669.2 56486.2 56791.7 76828.8 79850.6 80152.0 80519.2 81400.0 7713.0 7809.9 7976.7 8062.3 8129.1 11546.4 12274.4 12533.2 12543.7 12670.6 8918.5 10549.8 10564.6 10843.0 10976.5 10652.0 10680.5 10803.7 10972.6 11018.5 9325.2 10976.2 11107.0 11346.3 11370.8 7804.1 7946.6 8047.6 8061.2 8160.2 10558.7 10782.9 10871.0 11027.0 11054.2 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | [#3] mootools.html Cycles:180 Average:5424.44 Median:4780.62 stddev:3036.69 (63.5%) stddev-sans-first:3029.29 07:52:10 INFO - PROCESS | 2259 | Values: 1287.4 1445.3 1527.0 1672.0 1693.6 7510.6 7778.2 8177.3 8545.7 8567.2 7985.2 8312.9 8316.5 8452.5 8464.0 2262.6 2306.4 2309.6 2310.9 2324.7 2303.8 2337.9 2355.6 2362.5 2362.9 2295.1 2299.4 2317.4 2319.1 2321.3 2278.5 2284.6 2286.9 2306.5 2310.8 2306.6 2326.4 2329.7 2331.3 2338.6 8405.5 8449.7 8465.4 8482.9 8484.0 5024.9 5193.5 5197.0 5207.5 5216.4 3192.5 3380.6 3396.6 3522.9 3533.9 988.7 1050.5 1053.9 1066.1 1080.8 10857.9 10917.4 10940.0 10950.8 10985.9 3938.0 4462.9 4554.9 4682.2 4714.8 9388.9 9426.8 9463.4 9515.4 9571.3 4444.7 4576.6 5149.7 5161.2 5181.5 4059.7 4268.8 4389.8 4608.0 4747.7 3789.8 3819.0 3839.9 3908.0 3955.4 1254.4 1271.3 1281.5 1285.7 1295.2 751.0 852.5 857.7 867.0 871.1 5240.9 5246.3 5322.1 5550.6 5572.1 428.5 429.2 433.0 438.9 442.1 3515.8 3517.7 3553.7 3555.4 3627.6 9838.3 10072.8 10207.8 10216.5 10231.3 9508.7 10083.7 10085.9 10100.4 10118.5 7307.7 7622.3 7635.3 7658.8 7663.7 5543.0 5568.0 5594.0 5702.4 5713.1 9338.6 9384.7 9425.3 9480.8 9559.2 9607.9 9641.9 9656.3 9680.4 9748.0 6922.8 7115.3 7133.7 7215.3 7279.5 8014.7 8030.1 8071.8 8072.7 8097.8 7027.3 7064.5 7239.9 7295.9 7320.6 6887.8 7086.2 7122.1 7197.5 7263.2 6608.6 6658.7 6742.1 6771.0 6815.3 4724.2 4732.9 4773.1 4778.2 4783.0 4654.7 4691.2 4714.5 4829.0 4920.0 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | [#4] prototype.html Cycles:180 Average:4326.16 Median:4769.27 stddev:1325.40 (27.8%) stddev-sans-first:1293.43 07:52:10 INFO - PROCESS | 2259 | Values: 255.9 296.0 307.0 310.6 311.8 4759.5 4857.1 4899.3 5240.1 5321.3 5189.2 5253.9 5274.5 5365.5 5422.9 4071.8 4094.7 4098.8 4101.6 4115.4 3731.2 4021.3 4115.4 4120.8 4122.0 3355.0 3990.8 3994.5 3996.7 4007.1 3725.1 3876.6 3901.4 3960.6 4028.9 3464.1 3481.9 3488.3 3511.8 3521.7 4479.5 4671.3 4687.0 5045.0 5168.3 3894.3 4159.5 4351.6 4581.0 4619.8 4679.6 4882.3 5081.6 5570.4 5730.6 3080.9 3802.4 3840.1 3850.7 3856.7 4837.0 4947.0 5747.5 5860.6 5937.4 2985.7 3322.4 3717.2 3856.6 3885.9 3331.0 3751.4 3922.3 3938.9 3972.5 3666.7 4120.8 4498.0 4533.9 4560.5 4632.9 5147.9 5570.8 5574.0 5755.7 978.5 1220.4 1242.8 1258.2 1270.6 731.4 785.8 811.0 866.8 871.1 4918.5 4964.3 4984.1 5004.6 5009.6 4933.0 5023.8 5048.8 5467.8 5523.6 4313.1 4632.5 4782.6 4998.2 5056.1 2812.7 2828.5 2843.3 2868.9 2871.6 4805.8 5516.6 5659.9 5666.1 5673.6 4749.9 4799.2 4820.4 5419.0 5527.9 4859.1 4883.6 4950.6 5632.7 5680.4 4779.0 5238.0 5454.3 5480.5 5490.9 4502.2 4714.4 4754.5 4911.6 5333.6 5566.3 5582.3 5593.8 5640.9 5694.9 3053.6 3124.7 3275.8 3454.3 3613.6 4422.6 4426.6 4509.3 4676.1 4997.8 4634.6 4740.5 5207.9 5514.1 5575.3 4694.3 5329.5 5581.3 5638.3 5650.6 4606.0 4790.4 4958.6 5483.3 5502.4 4170.2 5449.9 5728.7 5730.5 5730.6 4503.2 5205.3 5216.3 5509.2 5630.3 07:52:10 INFO - PROCESS | 2259 | 07:52:10 INFO - PROCESS | 2259 | [#5] yui.html Cycles:180 Average:19462.46 Median:25638.53 stddev:28581.66 (111.5%) stddev-sans-first:28627.07 07:52:10 INFO - PROCESS | 2259 | Values: 688.1 691.7 742.4 765.5 785.9 13727.8 14527.0 14536.3 14557.5 14597.5 12367.9 12419.4 12425.3 12428.6 12473.1 639.1 663.0 780.8 808.6 814.0 806.9 811.3 813.6 816.0 818.0 871.0 873.1 874.3 876.7 877.3 858.9 862.0 867.2 867.4 869.2 620.9 641.4 641.9 642.9 645.4 13718.0 14020.3 14033.1 14076.6 14308.3 13776.8 13925.9 13960.7 14051.4 14055.9 9480.4 11114.2 11159.3 11292.9 11344.5 3589.8 3594.7 3623.2 3637.8 3647.5 83696.0 86081.0 90846.5 91661.0 94618.1 9519.3 10465.5 10536.4 10828.7 11233.7 21396.9 21627.8 21690.7 21823.6 21837.3 6009.5 7123.3 7247.7 7298.6 7313.1 4063.2 4140.6 4168.2 4226.4 4282.7 2804.7 3190.5 3283.2 3288.6 3288.6 497.9 506.3 521.7 526.4 527.8 544.6 592.2 598.2 605.3 619.3 6598.8 7850.2 8220.0 8758.8 9570.1 605.4 674.0 682.3 682.5 688.7 4023.6 4419.5 4489.1 4500.4 4570.7 70164.0 108314.5 108953.7 109502.3 109968.4 82397.0 89189.0 91528.0 93369.0 98595.5 72548.6 83589.0 85292.0 87309.0 89377.6 8822.7 9329.7 9369.9 9425.2 9438.3 37707.0 41390.0 50770.7 54092.7 54995.9 54437.5 57631.4 62920.4 70410.6 70420.6 9397.9 9880.9 11485.6 11680.6 12241.8 11821.4 13012.2 13313.9 13417.9 13432.3 11554.5 11647.9 11760.9 12162.5 12422.4 12284.3 12504.6 12542.6 12548.8 12766.2 11853.4 12048.8 12053.0 12149.5 12610.5 8297.8 10106.9 10147.1 10351.8 10429.3 8766.3 9233.0 10249.5 10255.0 10279.9 07:52:10 INFO - PROCESS | 2259 | -------- Summary: end -------- 07:52:10 INFO - PROCESS | 2259 | 07:52:11 INFO - TEST-INFO | 2259: exit 0 07:52:11 INFO - TEST-OK | dromaeo_css | took 1117601ms 07:52:11 INFO - TEST-START | kraken 07:52:11 INFO - operating with platform_type : mac_ 07:52:11 INFO - Initialising browser for kraken test... 07:52:11 INFO - TEST-INFO | started process 2264 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpzaL4MX/profile http://localhost:49496/getInfo.html) 07:52:14 INFO - PROCESS | 2264 | 2016-12-07 07:52:14.368 plugin-container[2265:286040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 07:52:14 INFO - PROCESS | 2264 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:14 INFO - PROCESS | 2264 | 2016-12-07 07:52:14.371 plugin-container[2265:286040] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x474b, name = 'com.apple.CFPasteboardClient' 07:52:14 INFO - PROCESS | 2264 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:14 INFO - PROCESS | 2264 | 2016-12-07 07:52:14.371 plugin-container[2265:286040] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:52:14 INFO - PROCESS | 2264 | __metrics Screen width/height:1600/1200 07:52:14 INFO - PROCESS | 2264 | colorDepth:24 07:52:14 INFO - PROCESS | 2264 | Browser inner width/height: 1024/689 07:52:14 INFO - PROCESS | 2264 | __metrics 07:52:14 ERROR - PROCESS | 2264 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 07:52:15 INFO - TEST-INFO | 2264: exit 0 07:52:15 INFO - Browser initialized. 07:52:15 INFO - Running cycle 1/1 for kraken test... 07:52:15 INFO - TEST-INFO | started process 2266 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/tmpzaL4MX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:18 INFO - PROCESS | 2266 | 2016-12-07 07:52:18.003 plugin-container[2267:286160] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a4b, name = 'com.apple.tsm.portname' 07:52:18 INFO - PROCESS | 2266 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:18 INFO - PROCESS | 2266 | 2016-12-07 07:52:18.004 plugin-container[2267:286160] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 07:52:18 INFO - PROCESS | 2266 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:52:18 INFO - PROCESS | 2266 | 2016-12-07 07:52:18.004 plugin-container[2267:286160] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:52:27 INFO - PROCESS | 2266 | RSS: Main: 229707776 07:52:27 INFO - PROCESS | 2266 | 07:52:30 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:31 INFO - PROCESS | 2266 | RSS: Main: 241688576 07:52:31 INFO - PROCESS | 2266 | 07:52:34 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-dft) 07:52:35 INFO - PROCESS | 2266 | RSS: Main: 249315328 07:52:35 INFO - PROCESS | 2266 | 07:52:38 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-fft) 07:52:39 INFO - PROCESS | 2266 | RSS: Main: 252874752 07:52:39 INFO - PROCESS | 2266 | 07:52:40 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49496/tests/kraken/driver.html?testName=audio-oscillator) 07:52:41 INFO - PROCESS | 2266 | RSS: Main: 254283776 07:52:41 INFO - PROCESS | 2266 | 07:52:43 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:44 INFO - PROCESS | 2266 | RSS: Main: 254627840 07:52:44 INFO - PROCESS | 2266 | 07:52:46 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:47 INFO - PROCESS | 2266 | RSS: Main: 259223552 07:52:47 INFO - PROCESS | 2266 | 07:52:50 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49496/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:51 INFO - PROCESS | 2266 | RSS: Main: 258273280 07:52:51 INFO - PROCESS | 2266 | 07:52:54 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49496/tests/kraken/driver.html?testName=json-parse-financial) 07:52:55 INFO - PROCESS | 2266 | RSS: Main: 258576384 07:52:55 INFO - PROCESS | 2266 | 07:52:56 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:57 INFO - PROCESS | 2266 | RSS: Main: 257347584 07:52:57 INFO - PROCESS | 2266 | 07:52:59 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:53:00 INFO - PROCESS | 2266 | RSS: Main: 257343488 07:53:00 INFO - PROCESS | 2266 | 07:53:02 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:53:02 INFO - PROCESS | 2266 | RSS: Main: 257400832 07:53:02 INFO - PROCESS | 2266 | 07:53:05 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:53:06 INFO - PROCESS | 2266 | RSS: Main: 257724416 07:53:06 INFO - PROCESS | 2266 | 07:53:09 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:53:10 INFO - PROCESS | 2266 | RSS: Main: 257585152 07:53:10 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | Cycle 1(1): loaded http://localhost:49496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49496/tests/kraken/driver.html?testName=ai-astar) 07:53:12 INFO - PROCESS | 2266 | RSS: Main: 259100672 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | __start_tp_report 07:53:12 INFO - PROCESS | 2266 | _x_x_mozilla_page_load 07:53:12 INFO - PROCESS | 2266 | _x_x_mozilla_page_load_details 07:53:12 INFO - PROCESS | 2266 | |i|pagename|runs| 07:53:12 INFO - PROCESS | 2266 | |0;ai-astar;105;119;121;119;118;121;123;168;174;118 07:53:12 INFO - PROCESS | 2266 | |1;audio-beat-detection;149;118;115;150;117;120;134;117;148;117 07:53:12 INFO - PROCESS | 2266 | |2;audio-dft;200;202;199;199;194;215;221;277;204;200 07:53:12 INFO - PROCESS | 2266 | |3;audio-fft;82;57;58;84;62;60;58;51;87;80 07:53:12 INFO - PROCESS | 2266 | |4;audio-oscillator;82;72;90;71;70;72;85;68;70;73 07:53:12 INFO - PROCESS | 2266 | |5;imaging-gaussian-blur;91;88;92;87;79;126;91;100;136;85 07:53:12 INFO - PROCESS | 2266 | |6;imaging-darkroom;154;121;96;97;97;97;97;96;96;97 07:53:12 INFO - PROCESS | 2266 | |7;imaging-desaturate;118;84;137;142;78;140;150;124;89;93 07:53:12 INFO - PROCESS | 2266 | |8;json-parse-financial;56;56;58;70;87;90;88;66;81;87 07:53:12 INFO - PROCESS | 2266 | |9;json-stringify-tinderbox;70;70;74;80;77;76;72;70;74;72 07:53:12 INFO - PROCESS | 2266 | |10;stanford-crypto-aes;86;86;86;88;83;84;87;88;86;85 07:53:12 INFO - PROCESS | 2266 | |11;stanford-crypto-ccm;156;169;149;144;170;161;173;164;202;293 07:53:12 INFO - PROCESS | 2266 | |12;stanford-crypto-pbkdf2;171;167;219;163;215;241;183;227;228;170 07:53:12 INFO - PROCESS | 2266 | |13;stanford-crypto-sha256-iterative;61;83;87;88;89;78;68;76;83;90 07:53:12 INFO - PROCESS | 2266 | __end_tp_report 07:53:12 INFO - PROCESS | 2266 | __start_cc_report 07:53:12 INFO - PROCESS | 2266 | _x_x_mozilla_cycle_collect,987 07:53:12 INFO - PROCESS | 2266 | __end_cc_report 07:53:12 INFO - PROCESS | 2266 | __startTimestamp1481125992701__endTimestamp 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | ------- Summary: start ------- 07:53:12 INFO - PROCESS | 2266 | Number of tests: 14 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#0] ai-astar Cycles:10 Average:128.60 Median:121.00 stddev:22.92 (18.9%) stddev-sans-first:22.66 07:53:12 INFO - PROCESS | 2266 | Values: 105.0 119.0 121.0 119.0 118.0 121.0 123.0 168.0 174.0 118.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:127.00 stddev:15.11 (11.9%) stddev-sans-first:14.09 07:53:12 INFO - PROCESS | 2266 | Values: 149.0 118.0 115.0 150.0 117.0 120.0 134.0 117.0 148.0 117.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#2] audio-dft Cycles:10 Average:211.10 Median:203.00 stddev:24.54 (12.1%) stddev-sans-first:25.70 07:53:12 INFO - PROCESS | 2266 | Values: 200.0 202.0 199.0 199.0 194.0 215.0 221.0 277.0 204.0 200.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#3] audio-fft Cycles:10 Average:67.90 Median:71.00 stddev:13.61 (19.2%) stddev-sans-first:13.44 07:53:12 INFO - PROCESS | 2266 | Values: 82.0 57.0 58.0 84.0 62.0 60.0 58.0 51.0 87.0 80.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:72.50 stddev:7.53 (10.4%) stddev-sans-first:7.58 07:53:12 INFO - PROCESS | 2266 | Values: 82.0 72.0 90.0 71.0 70.0 72.0 85.0 68.0 70.0 73.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:87.50 stddev:18.60 (21.3%) stddev-sans-first:19.58 07:53:12 INFO - PROCESS | 2266 | Values: 91.0 88.0 92.0 87.0 79.0 126.0 91.0 100.0 136.0 85.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#6] imaging-darkroom Cycles:10 Average:104.80 Median:97.00 stddev:18.91 (19.5%) stddev-sans-first:8.14 07:53:12 INFO - PROCESS | 2266 | Values: 154.0 121.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#7] imaging-desaturate Cycles:10 Average:115.50 Median:114.00 stddev:27.16 (23.8%) stddev-sans-first:28.80 07:53:12 INFO - PROCESS | 2266 | Values: 118.0 84.0 137.0 142.0 78.0 140.0 150.0 124.0 89.0 93.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#8] json-parse-financial Cycles:10 Average:73.90 Median:84.00 stddev:14.23 (16.9%) stddev-sans-first:13.54 07:53:12 INFO - PROCESS | 2266 | Values: 56.0 56.0 58.0 70.0 87.0 90.0 88.0 66.0 81.0 87.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#9] json-stringify-tinderbox Cycles:10 Average:73.50 Median:74.00 stddev:3.37 (4.6%) stddev-sans-first:3.33 07:53:12 INFO - PROCESS | 2266 | Values: 70.0 70.0 74.0 80.0 77.0 76.0 72.0 70.0 74.0 72.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:86.00 stddev:1.60 (1.9%) stddev-sans-first:1.69 07:53:12 INFO - PROCESS | 2266 | Values: 86.0 86.0 86.0 88.0 83.0 84.0 87.0 88.0 86.0 85.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#11] stanford-crypto-ccm Cycles:10 Average:178.10 Median:169.50 stddev:43.38 (25.6%) stddev-sans-first:45.27 07:53:12 INFO - PROCESS | 2266 | Values: 156.0 169.0 149.0 144.0 170.0 161.0 173.0 164.0 202.0 293.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.40 Median:217.00 stddev:30.26 (13.9%) stddev-sans-first:30.43 07:53:12 INFO - PROCESS | 2266 | Values: 171.0 167.0 219.0 163.0 215.0 241.0 183.0 227.0 228.0 170.0 07:53:12 INFO - PROCESS | 2266 | 07:53:12 INFO - PROCESS | 2266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:85.00 stddev:9.64 (11.3%) stddev-sans-first:7.26 07:53:12 INFO - PROCESS | 2266 | Values: 61.0 83.0 87.0 88.0 89.0 78.0 68.0 76.0 83.0 90.0 07:53:12 INFO - PROCESS | 2266 | -------- Summary: end -------- 07:53:12 INFO - PROCESS | 2266 | 07:53:13 INFO - TEST-INFO | 2266: exit 0 07:53:13 INFO - TEST-OK | kraken | took 62423ms 07:53:13 INFO - SUITE-END | took 1180s 07:53:13 INFO - Completed test suite (00:19:40) 07:53:13 INFO - javascript benchmark 07:53:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6986.389827477186, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.1574606348413, 3385.8137802420865, 3400.353932752777, 3415.214500664847, 3487.250241198142, 5676.829695109148, 5739.368669446358, 5758.827235182941, 5765.13522971554, 5802.216700745398, 5666.376698563155, 5700.686462244575, 5761.020626493496, 5773.971130144343, 5785.768569257235, 5228.843134705965, 5251.264822924774, 5253.238280449342, 5271.15661494161, 5287.814926477574, 5303.204519322094, 5315.867103322409, 5339.06566350889, 5344.171653393731, 5360.812371566996, 5164.561012313939, 5178.171492561191, 5292.311999440068, 5294.41761406245, 5298.205269209611, 5204.583633309327, 5221.86945326368, 5260.053190425722, 5302.151655735064, 5355.3305836770405, 5183.0, 5221.71280579568, 5246.081935661244, 5248.265242866002, 5289.710140601206, 5578.135389014709, 5739.827805165852, 5747.626404283708, 5831.970840145815, 5881.67650779207, 5040.0, 6111.227117700271, 6162.630242185438, 6166.044263139221, 6193.3496982816605, 6213.596116252429, 6214.844628884314, 6236.126942228092, 6248.96875515624, 6255.96872015637, 5882.117682347682, 5930.822075337746, 5938.435848594377, 5942.2275104236605, 5986.46121849027, 6148.800983808114, 6200.534959878028, 6200.906986395207, 6212.161358216583, 6219.253689557282, 6180.598261113013, 6187.907181392283, 6214.906776398358, 6217.502599792006, 6227.813165605039, 6162.815115546541, 6222.719977601018, 6226.719797609118, 6228.377162283826, 6244.75020999164, 5139.0, 6069.2110025696375, 6075.27096748393, 6154.076888466676, 6194.163787888578, 6189.50483961282, 6218.22272215973, 6230.06549017651, 6231.0, 6236.158118653923, 4886.315915771795, 4915.557599816034, 4916.901661966812, 4952.405711314594, 4956.107900577858, 4388.890277743082, 4397.912041759211, 4408.448943882015, 4411.117776444724, 4423.358613001097, 4865.5864251538305, 5836.270466191726, 5847.532197424196, 5923.378045305181, 5990.820275391745, 6164.907526387108, 6214.036824292242, 6214.8135555933395, 6227.252729672468, 6247.125402443661, 5571.721413929287, 5732.656040637492, 5765.250517432707, 5795.1886735857015, 5831.912521312183, 5273.736313184402, 5279.551238144801, 5292.0, 5305.442928492453, 5312.256284120226, 6380.170577824946, 6422.967885160544, 6434.453071488976, 6436.967815160894, 6487.0, 4422.668299877458, 6203.31763506005, 6253.249610046823, 6257.749690012349, 6273.874522509433, 6279.96860015697, 6289.465395441439, 6333.96833015832, 6336.809895703136, 6454.870902582016, 6151.169592105009, 6179.536534760001, 6195.845103872439, 6216.316205217513, 6227.878981783322, 6160.075988601746, 6203.565750397609, 6248.875022499434, 6251.4061164189325, 6260.561760676709, 5891.440313170242, 5966.492848107786, 6061.969690151521, 6077.544184186116, 6123.724432400463, 6029.849253768691, 6100.450959413674, 6102.908456373069, 6131.63210207389, 6132.9080063799975, 5707.372189059117, 6033.939660603338, 6057.757689692363, 6107.633541987495, 6130.448259656652, 6173.783917563043, 6174.44430001302, 6186.81439556814, 6227.564070515021, 6247.3440288769025, 4955.0337684151245, 5865.501432378125, 5884.029135192645, 6076.989187136469, 6088.6042407243385], "value": 5697.771928098251, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.4308565093413, 476.6234674607061, 506.46061944029606, 530.8619758862696, 550.6668465578325, 37783.81108094459, 39219.80390098049, 39413.40879886804, 39466.21067578647, 39499.605003950026, 30383.696163038363, 34735.78424755134, 39490.0, 39805.0, 39987.60012399875, 7722.613869306526, 9419.52902354883, 9424.434533927952, 9425.293103017268, 9426.811463770755, 9408.529573521297, 9445.386049906769, 9505.19205867502, 9515.381500202464, 9543.904560954406, 9422.387544809566, 9475.668351607696, 9491.098345657152, 9522.952385238064, 9536.809263814754, 9480.09939055792, 9501.572429240701, 9509.286803489731, 9512.38169518979, 9540.33217674763, 8009.839803203961, 9266.166045055978, 9346.532673366373, 9386.95306523463, 9389.295802814817, 38648.61351386478, 38915.805420972996, 38977.41533876994, 39166.41250381246, 39284.41073383902, 3263.2005158736024, 3283.8850640227715, 3702.185519185775, 3813.9427908581392, 3880.185161116169, 27737.0, 27900.16299511018, 28569.857150714113, 29653.473967014146, 29909.40181196364, 3024.6370435547874, 3172.936541269185, 3224.5163225516126, 3229.40256052631, 3299.224682199681, 367731.0, 373878.0, 374930.250697495, 375628.0, 375883.0, 57077.71461142668, 57283.713581431824, 57328.71335643295, 57419.712901435225, 57517.712411438515, 58031.41968580345, 58544.414555854746, 58628.827423451294, 58682.41317586855, 58864.41135588675, 15396.923015384851, 15680.607984800472, 15710.842891571167, 15718.371265149495, 15742.685146297239, 11965.581204657796, 12133.0, 12134.5146194153, 12181.817272740916, 12192.390380481118, 12388.256704597752, 14480.85519144795, 14806.777898331533, 14911.850881491046, 15027.924860375628, 3145.937081258362, 3239.093053944899, 3268.4607039838634, 6565.770198043141, 6764.864702706017, 873.3580818098692, 943.7168849345169, 954.9781733545041, 1021.8518314844306, 1022.943738094412, 25385.238442846374, 29161.56257656137, 29772.2556936074, 29966.55050174249, 30326.241843954078, 989.6585677941099, 1076.967690969272, 1109.683740134074, 1120.4229821641861, 1151.3034614058543, 14796.852031479762, 14832.925835370754, 15223.010504317184, 15318.846811531965, 15445.382184712711, 604732.0, 661668.0, 662843.0, 669155.6542217258, 670027.6498617475, 55369.72315138399, 55876.44123558794, 55888.16167757487, 55919.440805591425, 56281.718591407596, 1344.9932750336186, 1355.898307626932, 1377.9104358216684, 1386.3692020130816, 1386.729587730383, 28778.0, 29420.411591768472, 29425.411491770472, 29640.258993524472, 30226.24434389158, 46909.3581724638, 47949.280760787915, 47997.520024799305, 48033.75983120202, 48086.759566201945, 453414.0, 556128.0, 558952.0, 574062.0, 602914.98542507, 25316.493670126863, 25495.10767123216, 25542.616860747476, 25672.61491077598, 25729.485410292065, 35587.644123558435, 44614.10771784481, 45632.77183614061, 45825.77087114543, 46039.76980115078, 37204.44193337048, 37599.43600846044, 37761.81119094387, 38129.80935095418, 39114.4132838002, 37490.0, 38265.0, 38325.40191646918, 38637.80681096577, 38853.805730971166, 35710.64289357177, 36322.09194770152, 36952.63047369492, 37158.07104822401, 37603.0, 27682.584761228194, 29865.402691946474, 32276.67723322737, 33909.152271193416, 33931.660683393835, 25172.83165799174, 25320.620190696787, 25340.74659253384, 25651.743482564936, 25833.48333033291], "value": 18892.749655611682, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.9766015209012, 363.42034455044194, 370.8460988689693, 378.5117198813531, 390.82751744765704, 18321.816781832178, 18819.52951176221, 19675.212991480323, 19984.60030799385, 20139.496512587193, 19599.706004409945, 19807.207711691513, 19909.40271791845, 20287.59424811503, 20326.288579899705, 5608.971955140219, 5675.51758100562, 5928.466438020578, 5956.16613674086, 5979.073243647242, 5693.316801983768, 5892.528597712194, 5894.88210235795, 5896.321922978869, 5900.675462849542, 5571.415001424853, 5771.538276937856, 5836.270466191726, 5852.795152169675, 5855.79504717335, 5777.913331300034, 5826.388229235911, 5840.386759390267, 5856.736446859902, 5862.941370586283, 5078.136716758123, 5144.382674079097, 5167.715775632339, 5367.758450869681, 5435.891282174374, 12600.936995314965, 12863.42114604845, 12866.97064234859, 13574.728505429935, 23344.64983025256, 2133.445304220914, 2200.8239340852692, 2218.889055547232, 2231.921882734113, 2453.6810214671978, 8446.155384461566, 9607.855882161773, 9756.121949024551, 10177.592896284139, 11180.608678696288, 1761.6652835961254, 1774.2814160265114, 1816.6275913437714, 1822.298415110179, 1849.2602958816447, 107747.46126269396, 118435.40782296119, 118876.0, 118919.81080189174, 119511.0, 9423.623055077856, 11416.885831141748, 11542.711432214262, 11643.941780291045, 11819.231749936227, 14432.0, 14438.133711977314, 14438.639034024234, 14451.638709032148, 14456.0, 8007.07918589358, 8269.131741167092, 8297.917020829715, 8408.831823363498, 8415.873761893576, 8060.677572897019, 8072.152423995513, 8146.063202731643, 8214.35712857431, 8281.8343633127, 4395.208862404797, 4447.777611119496, 4449.1546606145375, 4451.5325890781005, 4519.389882365838, 1633.9264733087039, 1859.869809113349, 1923.5864289177894, 1924.28801343501, 1925.0182406972544, 711.697528550364, 754.984545785917, 879.1911441473859, 889.3952112563389, 926.8331700294012, 20169.0, 21155.47111322229, 21211.15155393767, 21400.464988375104, 21443.356699299045, 748.3713680508399, 887.3965703321803, 921.8154671247415, 957.0764212534938, 972.8832540095092, 9071.729957805912, 10767.97704218098, 10882.891171088346, 10961.232713709964, 11068.225224234387, 602230.0, 606632.0, 612291.0, 620739.0, 628375.0, 116445.0, 123606.0, 123867.0, 123879.0, 139216.0, 965.2856885904521, 997.4015590645699, 1008.294194064158, 1008.3395376028712, 1011.1304278320638, 14594.982507550041, 18558.81441185571, 19318.03409829531, 19328.71006934869, 19455.3190638327, 53233.4676653244, 53500.732496338824, 54669.1799622998, 56486.15270770859, 56791.71604141953, 76828.84756728541, 79850.6007469959, 80152.0, 80519.19480805116, 81400.0, 7713.0, 7809.882851757115, 7976.7208147714555, 8062.274395304451, 8129.065157506962, 11546.42267886619, 12274.4476498556, 12533.182688510296, 12543.686407839878, 12670.556530521388, 8918.464892106495, 10549.841752373566, 10564.577416903545, 10843.024127828534, 10976.506057227285, 10652.041316281571, 10680.465976700978, 10803.675889723321, 10972.615958441416, 11018.50416731233, 9325.160735533835, 10976.176786740867, 11107.0, 11346.319220846446, 11370.829437558277, 7804.141544429995, 7946.562939038177, 8047.623087017891, 8061.153578874134, 8160.18398160203, 10558.736031599272, 10782.892171078189, 10871.021608055313, 11027.0, 11054.22620416563], "value": 9240.210771642389, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.388490467028, 1445.2918070145624, 1526.9616660670747, 1671.9916400417987, 1693.618935739458, 7510.586917719524, 7778.222177782219, 8177.264046235838, 8545.658173673046, 8567.228949394554, 7985.241402066809, 8312.8753068704, 8316.501009939408, 8452.535110568917, 8463.957680211606, 2262.5814224368546, 2306.3888069661552, 2309.58427483053, 2310.8844557772127, 2324.7094113235844, 2303.7581053989343, 2337.9298621041394, 2355.587772139869, 2362.527494501098, 2362.8582285062867, 2295.0590257994227, 2299.356180269527, 2317.44381348476, 2319.1071437496516, 2321.3384185507134, 2278.464560828204, 2284.611616025263, 2286.931392058241, 2306.538692261546, 2310.7573704760925, 2306.550222706573, 2326.360250930991, 2329.6621989811383, 2331.3355693627236, 2338.637511185752, 8405.537695426749, 8449.704260350858, 8465.449745766568, 8482.915170848275, 8483.957580212122, 5024.899502009976, 5193.454687257859, 5197.0, 5207.479252074762, 5216.400113986902, 3192.4732419151046, 3380.6112297085906, 3396.557797546092, 3522.8943131705832, 3533.9044896082296, 988.6687959533565, 1050.5482642463737, 1053.9473026348728, 1066.0831684751108, 1080.783843231349, 10857.945710271399, 10917.39954302513, 10939.99999999992, 10950.835737463865, 10985.945070274678, 3937.9606203938165, 4462.9107417851465, 4554.863354099382, 4682.204025315705, 4714.764261786897, 9388.8591671125, 9426.764330891783, 9463.432194068379, 9515.429074255568, 9571.28215383849, 4444.73331600105, 4576.604135738565, 5149.665271757323, 5161.174212126042, 5181.53366197044, 4059.736117152435, 4268.829246830154, 4389.824407023747, 4607.976960115178, 4747.667663263607, 3789.829457674411, 3819.0, 3839.9424008639894, 3908.022994251437, 3955.3869150281753, 1254.3602762591145, 1271.3261971155118, 1281.4681907008487, 1285.7107150890974, 1295.164618820874, 751.0049184830121, 852.4586887326592, 857.7469646454311, 867.0116067682847, 871.0940621753432, 5240.895182096413, 5246.317978662826, 5322.148456246982, 5550.639208451518, 5572.0527510323345, 428.53289913993274, 429.21239525470486, 432.95873424414333, 438.8939871523806, 442.0650324563525, 3515.82420878955, 3517.736169787276, 3553.680168784822, 3555.377808883487, 3627.582827974764, 9838.3113182078, 10072.848907266396, 10207.846882296772, 10216.489175541343, 10231.28381013322, 9508.667196648084, 10083.747906302402, 10085.949570252102, 10100.444475553768, 10118.494075296207, 7307.744228951961, 7622.2758837910305, 7635.312821846061, 7658.770236892902, 7663.655135518915, 5543.0, 5568.0, 5593.972030139823, 5702.401247868914, 5713.085906254979, 9338.626454941726, 9384.67153649619, 9425.293103017439, 9480.810383792423, 9559.235261179228, 9607.903920960702, 9641.903580964381, 9656.32405731592, 9680.419174849532, 9748.025197480196, 6922.826929326807, 7115.324044215791, 7133.678984445816, 7215.278472152742, 7279.4540409470565, 8014.719484818003, 8030.076541197837, 8071.798205044921, 8072.677092916218, 8097.757067287991, 7027.297270272932, 7064.540804847668, 7239.8914016290855, 7295.8540829184185, 7320.560766353823, 6887.758928437481, 7086.185088714864, 7122.109736282965, 7197.46019048563, 7263.201047884834, 6608.603483790988, 6658.733650654113, 6742.08981787472, 6770.966145169243, 6815.284395138439, 4724.244120940633, 4732.905341893212, 4773.11697335994, 4778.235482322812, 4783.0, 4654.6741728078705, 4691.1555919934735, 4714.504976977505, 4828.95171048285, 4920.040592084509], "value": 4302.124720923539, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.8963619734008, 295.9526475763877, 306.953956906464, 310.5853685330084, 311.8487533546231, 4759.547842954914, 4857.1499987502175, 4899.305382039873, 5240.135377662686, 5321.3348331458565, 5189.169732842746, 5253.8949221015555, 5274.4967684210005, 5365.4976606550135, 5422.8915421691645, 4071.796410179494, 4094.733842300241, 4098.7540747555095, 4101.569335219804, 4115.403266526352, 3731.1977924746175, 4021.2761702893467, 4115.42384066231, 4120.8365608055865, 4122.0, 3354.9832250838713, 3990.840366385341, 3994.5419921728503, 3996.680265578747, 4007.056577559881, 3725.105974566112, 3876.6317199865966, 3901.4147877818273, 3960.6435420811977, 4028.939565906514, 3464.064702530328, 3481.9129521761906, 3488.3023395320783, 3511.7892926424497, 3521.7006554442905, 4479.513869802258, 4671.3226582145735, 4687.015726697397, 5045.0, 5168.286649509, 3894.2990261752875, 4159.521655009652, 4351.629236790401, 4580.984366878596, 4619.769011549442, 4679.649026323005, 4882.316475693406, 5081.568066714333, 5570.415106413809, 5730.598858079936, 3080.907572772798, 3802.39161734124, 3840.0591854995428, 3850.7497012694084, 3856.691464682847, 4836.951630483685, 4946.950530494649, 5747.482726554588, 5860.589758716891, 5937.406259374071, 2985.686093277727, 3322.401967645847, 3717.237966216919, 3856.5564960029396, 3885.86399476017, 3331.000699790102, 3751.4056525976353, 3922.3135951208424, 3938.8774199353047, 3972.503437070366, 3666.688331491853, 4120.7733574653685, 4497.955020449819, 4533.909321813545, 4560.540626999395, 4632.884177895579, 5147.940823670487, 5570.777168913279, 5574.024545704486, 5755.683437410982, 978.5498670611456, 1220.365409986802, 1242.7700875338091, 1258.1947553565726, 1270.6315168601186, 731.4221764805744, 785.7642707187821, 811.0348685064754, 866.8179682266668, 871.0940621753432, 4918.508149185053, 4964.304997300381, 4984.0811287654515, 5004.599632029429, 5009.599232061426, 4932.975335123301, 5023.819402440424, 5048.844472204872, 5467.835964921059, 5523.558115350762, 4313.094250207429, 4632.4672662644225, 4782.556559277315, 4998.200647766801, 5056.115179843513, 2812.662480502353, 2828.5291648342745, 2843.331817023039, 2868.9282767930968, 2871.6410448693914, 4805.807767689324, 5516.586256030814, 5659.858503537444, 5666.0735349981205, 5673.631213971079, 4749.857504274877, 4799.216943582974, 4820.4456487504385, 5419.0, 5527.861803454945, 4859.092316760098, 4883.584895283941, 4950.638574391999, 5632.662040277596, 5680.431956804369, 4779.0, 5237.952409518188, 5454.3454785426, 5480.534154596904, 5490.945090549043, 4502.234620114523, 4714.38712967312, 4754.500777418321, 4911.582515486224, 5333.626646134733, 5566.276384070045, 5582.320486166744, 5593.7556217393, 5640.887182256414, 5694.943050569441, 3053.603031605877, 3124.6562878083846, 3275.8034517929, 3454.29187016666, 3613.638636136365, 4422.579854913778, 4426.627745398937, 4509.2559727644575, 4676.111538807616, 4997.807978956674, 4634.606058484932, 4740.549647783455, 5207.92188117171, 5514.117741161395, 5575.303087114111, 4694.2958556216845, 5329.520343169133, 5581.274434323512, 5638.2670252866865, 5650.604457687922, 4606.0, 4790.353302304145, 4958.628102892226, 5483.298773327908, 5502.449755024466, 4170.186813571325, 5449.918251226314, 5728.742206600797, 5730.484256416942, 5730.598858079894, 4503.166914120898, 5205.297284866646, 5216.347956505437, 5509.201165831012, 5630.2680651516675], "value": 3901.0903634468546, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.0711040095869, 691.6921969723473, 742.3652776875771, 765.5330248548388, 785.9017622797151, 13727.79408308875, 14527.0, 14536.3458644361, 14557.490487832927, 14597.489087881926, 12367.938160309186, 12419.441125149368, 12425.31660758658, 12428.565000224993, 12473.126881118325, 639.1084437210078, 663.0419044480727, 780.7540624703229, 808.5795386399069, 813.9877901831477, 806.8749343851713, 811.3225456743626, 813.6257321632056, 816.049302562514, 817.9959100204491, 871.0331531999476, 873.1137895036543, 874.2656168818191, 876.7238319929234, 877.3113106211625, 858.9141085891423, 861.9784505387353, 867.2195024477958, 867.41449521573, 869.2437579306013, 620.9316975132732, 641.3650486018854, 641.9261784894703, 642.9453496452807, 645.441692935612, 13718.039737218398, 14020.29898505081, 14033.087849289866, 14076.577702668936, 14308.28458577067, 13776.793348099787, 13925.930370348186, 13960.720785584333, 14051.367688454044, 14055.859441405659, 9480.383775054599, 11114.22200445969, 11159.27464714791, 11292.943535282353, 11344.48949797261, 3589.838457269429, 3594.6944509716704, 3623.2391197848483, 3637.781733095996, 3647.544056992876, 83696.0, 86081.0, 90846.5457672714, 91661.0, 94618.05381946231, 9519.333646644807, 10465.529051192714, 10536.367817930948, 10828.675139745821, 11233.66299011031, 21396.893015534824, 21627.78372216289, 21690.674639880413, 21823.563528729654, 21837.344879653636, 6009.549283803733, 7123.2520585338825, 7247.746328878464, 7298.56208627484, 7313.12242530889, 4063.2076745034433, 4140.585941405896, 4168.187203495289, 4226.429432026698, 4282.721623094489, 2804.7055059218897, 3190.457622204231, 3283.195617073832, 3288.605367355885, 3288.605367355885, 497.93526841510374, 506.30888836737586, 521.6531006880458, 526.3578434310135, 527.8205410160564, 544.599719206383, 592.1768741449389, 598.2163365990566, 605.306923572507, 619.2568917299259, 6598.832560371049, 7850.214978502104, 8219.97250343707, 8758.781030474289, 9570.138687518018, 605.3825098399695, 673.9696713647897, 682.3244987462376, 682.5392859819701, 688.6935313785317, 4023.637872591481, 4419.469663640384, 4489.1021795641, 4500.422318278903, 4570.680052396367, 70164.0, 108314.45842770893, 108953.71831492377, 109502.26244343795, 109968.35047474294, 82397.0, 89189.0, 91528.0, 93369.0, 98595.50702246443, 72548.63725681338, 83589.0, 85292.0, 87309.0, 89377.55311223402, 8822.691205808023, 9329.72010839676, 9369.906300936904, 9425.151736343762, 9438.292128090283, 37707.0, 41390.0, 50770.74614626903, 54092.72953635207, 54995.90008199894, 54437.45562544324, 57631.42368576428, 62920.37079629328, 70410.64794675994, 70420.64789676019, 9397.864076706774, 9880.913099559186, 11485.598004069818, 11680.649580512598, 12241.816372754238, 11821.408929553316, 13012.154209976321, 13313.933430333174, 13417.926565874512, 13432.328383580587, 11554.480048397674, 11647.88352116468, 11760.945669924358, 12162.513499460276, 12422.37888105573, 12284.262944223376, 12504.624861253813, 12542.623721288375, 12548.811767823672, 12766.234025958473, 11853.407329633656, 12048.75902481963, 12053.0, 12149.453274602487, 12610.49558017669, 8297.83404331922, 10106.89893101089, 10147.086762191439, 10351.844722329322, 10429.26995110335, 8766.254868336262, 9232.95383523078, 10249.487525623837, 10255.025772551595, 10279.94860025695], "value": 6964.948749417033, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 119.0, 121.0, 119.0, 118.0, 121.0, 123.0, 168.0, 174.0, 118.0], "value": 128.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 115.0, 150.0, 117.0, 120.0, 134.0, 117.0, 148.0, 117.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 199.0, 199.0, 194.0, 215.0, 221.0, 277.0, 204.0, 200.0], "value": 211.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 58.0, 84.0, 62.0, 60.0, 58.0, 51.0, 87.0, 80.0], "value": 67.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 72.0, 90.0, 71.0, 70.0, 72.0, 85.0, 68.0, 70.0, 73.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 92.0, 87.0, 79.0, 126.0, 91.0, 100.0, 136.0, 85.0], "value": 97.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0], "value": 104.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 84.0, 137.0, 142.0, 78.0, 140.0, 150.0, 124.0, 89.0, 93.0], "value": 115.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 70.0, 87.0, 90.0, 88.0, 66.0, 81.0, 87.0], "value": 73.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 74.0, 80.0, 77.0, 76.0, 72.0, 70.0, 74.0, 72.0], "value": 73.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 88.0, 83.0, 84.0, 87.0, 88.0, 86.0, 85.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 169.0, 149.0, 144.0, 170.0, 161.0, 173.0, 164.0, 202.0, 293.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 219.0, 163.0, 215.0, 241.0, 183.0, 227.0, 228.0, 170.0], "value": 198.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 83.0, 87.0, 88.0, 89.0, 78.0, 68.0, 76.0, 83.0, 90.0], "value": 80.3, "unit": "score"}]}]} 07:53:13 INFO - Return code: 0 07:53:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:53:13 ERROR - # TBPL SUCCESS # 07:53:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:53:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:53:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:53:13 INFO - 2016-12-07 07:53:13.984 screenresolution[2272:286573] starting screenresolution argv=screenresolution get 07:53:13 INFO - 2016-12-07 07:53:13.987 screenresolution[2272:286573] Display 0: 1600x1200x32@60 07:53:13 INFO - 2016-12-07 07:53:13.993 screenresolution[2273:286575] starting screenresolution argv=screenresolution list 07:53:13 INFO - Available Modes on Display 0 07:53:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:53:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:53:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:53:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:53:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:53:14 INFO - Intel Iris: 07:53:14 INFO - Chipset Model: Intel Iris 07:53:14 INFO - Type: GPU 07:53:14 INFO - Bus: Built-In 07:53:14 INFO - VRAM (Dynamic, Max): 1536 MB 07:53:14 INFO - Vendor: Intel (0x8086) 07:53:14 INFO - Device ID: 0x0a2e 07:53:14 INFO - Revision ID: 0x0009 07:53:14 INFO - Displays: 07:53:14 INFO - Display: 07:53:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:53:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:53:14 INFO - Display Serial Number: 1600x1200 60 07:53:14 INFO - Main Display: Yes 07:53:14 INFO - Mirror: Off 07:53:14 INFO - Online: Yes 07:53:14 INFO - Rotation: Supported 07:53:14 INFO - Return code: 0 07:53:14 INFO - Running post-action listener: _resource_record_post_action 07:53:14 INFO - [mozharness: 2016-12-07 15:53:14.238519Z] Finished run-tests step (success) 07:53:14 INFO - Running post-run listener: _resource_record_post_run 07:53:14 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 1504768; Write bytes: 661813248; Read time: 15; Write time: 2050 07:53:14 INFO - TinderboxPrint: CPU usage
54.3% 07:53:14 INFO - TinderboxPrint: I/O read bytes / time
1,504,768 / 15 07:53:14 INFO - TinderboxPrint: I/O write bytes / time
661,813,248 / 2,050 07:53:14 INFO - TinderboxPrint: CPU idle
2,218.5 (45.7%) 07:53:14 INFO - TinderboxPrint: CPU system
982.1 (20.3%) 07:53:14 INFO - TinderboxPrint: CPU user
1,649.1 (34.0%) 07:53:14 INFO - TinderboxPrint: Swap in / out
349,732,864 / 0 07:53:14 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345602560; Write bytes: 347460096; Read time: 26782; Write time: 693 07:53:14 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1467904; Write bytes: 307164672; Read time: 14; Write time: 1327 07:53:14 INFO - Running post-run listener: _upload_blobber_files 07:53:14 INFO - Blob upload gear active. 07:53:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:53:14 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 07:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:53:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:53:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:16 INFO - (blobuploader) - INFO - Done attempting. 07:53:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:53:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:53:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:17 INFO - (blobuploader) - INFO - Done attempting. 07:53:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:53:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:53:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:19 INFO - (blobuploader) - INFO - Done attempting. 07:53:19 INFO - (blobuploader) - INFO - Iteration through files over. 07:53:19 INFO - Return code: 0 07:53:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:53:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:53:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e2871df0d51aed9fe28d248238dd1a411fc3d08fafe8bae5a0ad09dcaf45890d7f3d646ce1330677ce04d69943319209932e1b53624031febbfc6760d1e09c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c92ce356ccb49e4946f707655b8eb684dbf800301843be659c70fa62ce385452419fe3ace2a1f74751a6b686a624d7e0e42a3e2d5b76a15ac6c42574e80c36f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c50ee049bb9568e52db4fdbda00f14f26fc98c3ca6b65698f3f8448b826a87cc908b715dee1e328eb1af92f55376e3f30b39cc47566597251f9855bbe425c6d"} 07:53:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:53:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:53:19 INFO - Contents: 07:53:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e2871df0d51aed9fe28d248238dd1a411fc3d08fafe8bae5a0ad09dcaf45890d7f3d646ce1330677ce04d69943319209932e1b53624031febbfc6760d1e09c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c92ce356ccb49e4946f707655b8eb684dbf800301843be659c70fa62ce385452419fe3ace2a1f74751a6b686a624d7e0e42a3e2d5b76a15ac6c42574e80c36f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c50ee049bb9568e52db4fdbda00f14f26fc98c3ca6b65698f3f8448b826a87cc908b715dee1e328eb1af92f55376e3f30b39cc47566597251f9855bbe425c6d"} 07:53:19 INFO - Running post-run listener: copy_logs_to_upload_dir 07:53:19 INFO - Copying logs to upload dir... 07:53:19 INFO - mkdir: /builds/slave/test/build/upload/logs 07:53:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.208477 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-12-07 07:53:19.678756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 07:53:19.682865) ========= 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.PeGmouhOfR/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.F8wd67ZidR/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e2871df0d51aed9fe28d248238dd1a411fc3d08fafe8bae5a0ad09dcaf45890d7f3d646ce1330677ce04d69943319209932e1b53624031febbfc6760d1e09c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c92ce356ccb49e4946f707655b8eb684dbf800301843be659c70fa62ce385452419fe3ace2a1f74751a6b686a624d7e0e42a3e2d5b76a15ac6c42574e80c36f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c50ee049bb9568e52db4fdbda00f14f26fc98c3ca6b65698f3f8448b826a87cc908b715dee1e328eb1af92f55376e3f30b39cc47566597251f9855bbe425c6d"} build_url:https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/Kh_tlUElQJam_hBde7nVNQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2e2871df0d51aed9fe28d248238dd1a411fc3d08fafe8bae5a0ad09dcaf45890d7f3d646ce1330677ce04d69943319209932e1b53624031febbfc6760d1e09c7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6c92ce356ccb49e4946f707655b8eb684dbf800301843be659c70fa62ce385452419fe3ace2a1f74751a6b686a624d7e0e42a3e2d5b76a15ac6c42574e80c36f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9c50ee049bb9568e52db4fdbda00f14f26fc98c3ca6b65698f3f8448b826a87cc908b715dee1e328eb1af92f55376e3f30b39cc47566597251f9855bbe425c6d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 07:53:19.717937) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:53:19.718286) ========= 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.PeGmouhOfR/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.F8wd67ZidR/Listeners TMPDIR=/var/folders/kx/7l4fx3453sv4mdb6z4lz3d3m00000w/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.005372 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:53:19.767507) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 07:53:19.767843) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 07:53:19.768174) ========= ========= Total master_lag: 0.18 =========