builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0171 starttime: 1481106146.78 results: success (0) buildid: 20161207004003 builduid: 5531c0c769ca4646878faed60e9da998 revision: 6c2cb17c6db341f49599522c4fb1350b7c37b9e0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:26.783482) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:26.783834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:26.784121) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:27.036406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:27.036813) ========= 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.BJgXfW7fQJ/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.p303yaThw8/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:22:27-- 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% 151M=0s 2016-12-07 02:22:27 (151 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165372 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:27.229437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:27.229829) ========= 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.BJgXfW7fQJ/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.p303yaThw8/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.020075 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:27.283905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 02:22:27.284249) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c2cb17c6db341f49599522c4fb1350b7c37b9e0 --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 6c2cb17c6db341f49599522c4fb1350b7c37b9e0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BJgXfW7fQJ/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.p303yaThw8/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:22:27,360 truncating revision to first 12 chars 2016-12-07 02:22:27,360 Setting DEBUG logging. 2016-12-07 02:22:27,360 attempt 1/10 2016-12-07 02:22:27,360 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c2cb17c6db3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 02:22:29,039 unpacking tar archive at: mozilla-aurora-6c2cb17c6db3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.926162 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-07 02:22:29.238630) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:29.239224) ========= script_repo_revision: 6c2cb17c6db341f49599522c4fb1350b7c37b9e0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:29.239827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:29.240103) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 02:22:29.260172) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-12-07 02:22:29.260772) ========= /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.BJgXfW7fQJ/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.p303yaThw8/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:22:29 INFO - MultiFileLogger online at 20161207 02:22:29 in /builds/slave/test 02:22:29 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 02:22:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:22:29 INFO - {'append_to_log': False, 02:22:29 INFO - 'base_work_dir': '/builds/slave/test', 02:22:29 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:22:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:22:29 INFO - 'branch': 'Mozilla-Aurora', 02:22:29 INFO - 'buildbot_json_path': 'buildprops.json', 02:22:29 INFO - 'config_files': ('talos/mac_config.py',), 02:22:29 INFO - 'default_actions': ('clobber', 02:22:29 INFO - 'read-buildbot-config', 02:22:29 INFO - 'download-and-extract', 02:22:29 INFO - 'populate-webroot', 02:22:29 INFO - 'create-virtualenv', 02:22:29 INFO - 'install', 02:22:29 INFO - 'run-tests'), 02:22:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:22:29 INFO - 'download_minidump_stackwalk': True, 02:22:29 INFO - 'download_symbols': 'ondemand', 02:22:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:22:29 INFO - 'tooltool.py': '/tools/tooltool.py', 02:22:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:22:29 INFO - '/tools/misc-python/virtualenv.py')}, 02:22:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:22:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:22:29 INFO - 'installer_path': 'installer.exe', 02:22:29 INFO - 'log_level': 'info', 02:22:29 INFO - 'log_name': 'talos', 02:22:29 INFO - 'log_to_console': True, 02:22:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:22:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:22:29 INFO - 'opt_config_files': (), 02:22:29 INFO - 'pip_index': False, 02:22:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:22:29 INFO - 'cmd': ('bash', 02:22:29 INFO - '-c', 02:22:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:22:29 INFO - 'enabled': True, 02:22:29 INFO - 'halt_on_failure': False, 02:22:29 INFO - 'name': 'check_screen_resolution'},), 02:22:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:22:29 INFO - 'cmd': ('bash', 02:22:29 INFO - '-c', 02:22:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:22:29 INFO - 'enabled': True, 02:22:29 INFO - 'halt_on_failure': False, 02:22:29 INFO - 'name': 'check_screen_resolution'},), 02:22:29 INFO - 'run_cmd_checks_enabled': True, 02:22:29 INFO - 'sps_profile': False, 02:22:29 INFO - 'sps_profile_interval': 0, 02:22:29 INFO - 'suite': 'dromaeojs-e10s', 02:22:29 INFO - 'system_bits': '32', 02:22:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:22:29 INFO - 'title': 't-yosemite-r7-0171', 02:22:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:22:29 INFO - 'use_talos_json': True, 02:22:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:22:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:22:29 INFO - 'work_dir': 'build'} 02:22:29 INFO - [mozharness: 2016-12-07 10:22:29.460026Z] Running clobber step. 02:22:29 INFO - Running pre-action listener: _resource_record_pre_action 02:22:29 INFO - Running main action method: clobber 02:22:29 INFO - rmtree: /builds/slave/test/build 02:22:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:22:29 INFO - Running post-action listener: _resource_record_post_action 02:22:29 INFO - [mozharness: 2016-12-07 10:22:29.844510Z] Finished clobber step (success) 02:22:29 INFO - [mozharness: 2016-12-07 10:22:29.844639Z] Running read-buildbot-config step. 02:22:29 INFO - Running pre-action listener: _resource_record_pre_action 02:22:29 INFO - Running main action method: read_buildbot_config 02:22:29 INFO - Using buildbot properties: 02:22:29 INFO - { 02:22:29 INFO - "project": "", 02:22:29 INFO - "product": "firefox", 02:22:29 INFO - "script_repo_revision": "production", 02:22:29 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:22:29 INFO - "repository": "", 02:22:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:22:29 INFO - "buildid": "20161207004003", 02:22:29 INFO - "stage_platform": "macosx64", 02:22:29 INFO - "basedir": "/builds/slave/test", 02:22:29 INFO - "nightly_build": "True", 02:22:29 INFO - "buildnumber": 45, 02:22:29 INFO - "slavename": "t-yosemite-r7-0171", 02:22:29 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:22:29 INFO - "platform": "yosemite_r7", 02:22:29 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:22:29 INFO - "branch": "mozilla-aurora", 02:22:29 INFO - "repo_path": "releases/mozilla-aurora", 02:22:29 INFO - "revision": "6c2cb17c6db341f49599522c4fb1350b7c37b9e0", 02:22:29 INFO - "pgo_build": "False", 02:22:29 INFO - "builduid": "5531c0c769ca4646878faed60e9da998", 02:22:29 INFO - "slavebuilddir": "test" 02:22:29 INFO - } 02:22:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:22:29 INFO - Running post-action listener: _resource_record_post_action 02:22:29 INFO - [mozharness: 2016-12-07 10:22:29.848113Z] Finished read-buildbot-config step (success) 02:22:29 INFO - [mozharness: 2016-12-07 10:22:29.848218Z] Running download-and-extract step. 02:22:29 INFO - Running pre-action listener: _resource_record_pre_action 02:22:29 INFO - Running main action method: download_and_extract 02:22:29 INFO - mkdir: /builds/slave/test/build/tests 02:22:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:22:29 INFO - trying https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:22:29 INFO - Downloading https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/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 02:22:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/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 02:22:30 INFO - Downloaded 1199 bytes. 02:22:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:22:30 INFO - Using the following test package requirements: 02:22:30 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:22:30 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:22:30 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:22:30 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'jsshell-mac.zip'], 02:22:30 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:22:30 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:22:30 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:22:30 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:22:30 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:22:30 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:22:30 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:22:30 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:22:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:22:30 INFO - Fetch https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:22:31 INFO - Http code: 200 02:22:31 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 02:22:31 INFO - x-amz-cf-id: qfWvefAJlLQ0wYCznmlcsJE7iUMarOTJyUcMS-KSYQZQ8PMKk-Nlxg== 02:22:31 INFO - x-amz-version-id: b5.Nk4DVmMfWsSqaem97PtEePI_HnpHf 02:22:31 INFO - Expected file size: 16282027 02:22:31 INFO - Obtained file size: 16282027 02:22:38 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 02:22:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:22:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:22:38 INFO - Fetch https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:22:38 INFO - Http code: 200 02:22:38 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 02:22:38 INFO - x-amz-cf-id: u9GmgjCHt_UaeZnFBQlP7BhBOv_Zh61p_-srU8vk-iVRpWHvDE3iPw== 02:22:38 INFO - x-amz-version-id: b5.Nk4DVmMfWsSqaem97PtEePI_HnpHf 02:22:38 INFO - Expected file size: 16282027 02:22:38 INFO - Obtained file size: 16282027 02:22:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:22:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:22:45 INFO - Fetch https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:22:46 INFO - Http code: 200 02:22:46 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 02:22:46 INFO - x-amz-cf-id: qHBnxKTauTpMBWNhec9Lm0u4cyKp6MnHIAdSeqXzPCkctLj7_bTf9w== 02:22:46 INFO - x-amz-version-id: O8MQSzEMser55TtcE4pOzKDfg88sSkeH 02:22:46 INFO - Expected file size: 14409038 02:22:46 INFO - Obtained file size: 14409038 02:22:47 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')]} 02:22:47 INFO - trying https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/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 02:22:50 INFO - Downloaded 109859208 bytes. 02:22:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:22:50 INFO - mkdir: /builds/slave/test/properties 02:22:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:22:50 INFO - Writing to file /builds/slave/test/properties/build_url 02:22:50 INFO - Contents: 02:22:50 INFO - build_url:https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:22:51 INFO - Running post-action listener: _resource_record_post_action 02:22:51 INFO - Running post-action listener: set_extra_try_arguments 02:22:51 INFO - [mozharness: 2016-12-07 10:22:51.417837Z] Finished download-and-extract step (success) 02:22:51 INFO - [mozharness: 2016-12-07 10:22:51.417999Z] Running populate-webroot step. 02:22:51 INFO - Running pre-action listener: _resource_record_pre_action 02:22:51 INFO - Running main action method: populate_webroot 02:22:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:22:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:22:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:22:51 INFO - '--tppagecycles', 02:22:51 INFO - '7'], 02:22:51 INFO - 'tests': ['tsvgm']}}, 02:22:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:22:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:22:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:22:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:22:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:22:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['damp', 'tps']}, 02:22:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'tests': ['damp', 'tps']}, 02:22:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['dromaeo_dom']}, 02:22:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:22:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['basic_compositor_video']}, 02:22:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:22:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['a11yr', 02:22:51 INFO - 'ts_paint', 02:22:51 INFO - 'tpaint', 02:22:51 INFO - 'sessionrestore', 02:22:51 INFO - 'sessionrestore_no_auto_restore', 02:22:51 INFO - 'tabpaint']}, 02:22:51 INFO - 'other-e10s': {'tests': ['a11yr', 02:22:51 INFO - 'ts_paint', 02:22:51 INFO - 'tpaint', 02:22:51 INFO - 'sessionrestore', 02:22:51 INFO - 'sessionrestore_no_auto_restore', 02:22:51 INFO - 'tabpaint']}, 02:22:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:22:51 INFO - 'ts_paint', 02:22:51 INFO - 'tpaint', 02:22:51 INFO - 'sessionrestore', 02:22:51 INFO - 'sessionrestore_no_auto_restore', 02:22:51 INFO - 'tabpaint']}, 02:22:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:22:51 INFO - 'ts_paint', 02:22:51 INFO - 'tpaint', 02:22:51 INFO - 'sessionrestore', 02:22:51 INFO - 'sessionrestore_no_auto_restore', 02:22:51 INFO - 'tabpaint']}, 02:22:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['a11yr', 02:22:51 INFO - 'ts_paint', 02:22:51 INFO - 'tpaint', 02:22:51 INFO - 'sessionrestore', 02:22:51 INFO - 'sessionrestore_no_auto_restore', 02:22:51 INFO - 'tabpaint']}, 02:22:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['a11yr', 02:22:51 INFO - 'ts_paint', 02:22:51 INFO - 'tpaint', 02:22:51 INFO - 'sessionrestore', 02:22:51 INFO - 'sessionrestore_no_auto_restore', 02:22:51 INFO - 'tabpaint']}, 02:22:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['tsvgx', 02:22:51 INFO - 'tsvgr_opacity', 02:22:51 INFO - 'tart', 02:22:51 INFO - 'tscrollx', 02:22:51 INFO - 'cart']}, 02:22:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:22:51 INFO - 'tsvgr_opacity', 02:22:51 INFO - 'tart', 02:22:51 INFO - 'tscrollx', 02:22:51 INFO - 'cart']}, 02:22:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'talos_options': ['--disable-e10s'], 02:22:51 INFO - 'tests': ['tp5o']}, 02:22:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'tests': ['tp5o']}, 02:22:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'talos_options': ['--disable-e10s', 02:22:51 INFO - '--xperf_path', 02:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:51 INFO - 'tests': ['tp5n']}, 02:22:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:22:51 INFO - 'talos_options': ['--xperf_path', 02:22:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:22:51 INFO - 'tests': ['tp5n']}}, 02:22:51 INFO - 'talos.zip': {'path': '', 02:22:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:22:51 INFO - Running post-action listener: _resource_record_post_action 02:22:51 INFO - [mozharness: 2016-12-07 10:22:51.436550Z] Finished populate-webroot step (success) 02:22:51 INFO - [mozharness: 2016-12-07 10:22:51.436639Z] Running create-virtualenv step. 02:22:51 INFO - Running pre-action listener: _resource_record_pre_action 02:22:51 INFO - Running main action method: create_virtualenv 02:22:51 INFO - Creating virtualenv /builds/slave/test/build/venv 02:22:51 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 02:22:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:22:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:22:51 INFO - Using real prefix '/tools/python27' 02:22:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:22:52 INFO - Installing distribute.............................................................................................................................................................................................done. 02:22:55 INFO - Installing pip.................done. 02:22:55 INFO - Return code: 0 02:22:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:22:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:22:55 INFO - Reading from file tmpfile_stdout 02:22:55 INFO - Output received: 02:22:55 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) 02:22:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:22:55 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 02:22:55 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 02:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:55 INFO - 'HOME': '/Users/cltbld', 02:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:55 INFO - 'LOGNAME': 'cltbld', 02:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:55 INFO - 'MOZ_NO_REMOTE': '1', 02:22:55 INFO - 'NO_EM_RESTART': '1', 02:22:55 INFO - 'PAGER': '/bin/cat', 02:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:55 INFO - 'PWD': '/builds/slave/test', 02:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:55 INFO - 'SHELL': '/bin/bash', 02:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:22:55 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:55 INFO - 'USER': 'cltbld', 02:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:55 INFO - 'XPC_FLAGS': '0x0', 02:22:55 INFO - 'XPC_SERVICE_NAME': '0', 02:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:55 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 02:22:55 INFO - Cleaning up... 02:22:55 INFO - Return code: 0 02:22:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:22: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')]} 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22: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')]} 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:22:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:22:55 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:22:55 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 02:22:55 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 02:22:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:22:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:22:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:22:55 INFO - 'HOME': '/Users/cltbld', 02:22:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:22:55 INFO - 'LOGNAME': 'cltbld', 02:22:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:22:55 INFO - 'MOZ_NO_REMOTE': '1', 02:22:55 INFO - 'NO_EM_RESTART': '1', 02:22:55 INFO - 'PAGER': '/bin/cat', 02:22:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:22:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:22:55 INFO - 'PWD': '/builds/slave/test', 02:22:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:22:55 INFO - 'SHELL': '/bin/bash', 02:22:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:22:55 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:22:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:22:55 INFO - 'USER': 'cltbld', 02:22:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:22:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:22:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:22:55 INFO - 'XPC_FLAGS': '0x0', 02:22:55 INFO - 'XPC_SERVICE_NAME': '0', 02:22:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:22:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:22:55 INFO - Downloading/unpacking psutil>=3.1.1 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:22:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:22:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:22:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:22:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:22:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:00 INFO - Installing collected packages: psutil 02:23:00 INFO - Running setup.py install for psutil 02:23:00 INFO - building 'psutil._psutil_osx' extension 02:23:00 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 02:23:00 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 02:23:00 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 02:23:00 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 02:23:00 INFO - building 'psutil._psutil_posix' extension 02:23:00 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 02:23:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:23:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:23:00 INFO - ^ 02:23:00 INFO - 1 warning generated. 02:23:00 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 02:23:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:00 INFO - Successfully installed psutil 02:23:00 INFO - Cleaning up... 02:23:00 INFO - Return code: 0 02:23:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:23:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:00 INFO - 'HOME': '/Users/cltbld', 02:23:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:00 INFO - 'LOGNAME': 'cltbld', 02:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:00 INFO - 'MOZ_NO_REMOTE': '1', 02:23:00 INFO - 'NO_EM_RESTART': '1', 02:23:00 INFO - 'PAGER': '/bin/cat', 02:23:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:00 INFO - 'PWD': '/builds/slave/test', 02:23:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:00 INFO - 'SHELL': '/bin/bash', 02:23:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:00 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:00 INFO - 'USER': 'cltbld', 02:23:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:00 INFO - 'XPC_FLAGS': '0x0', 02:23:00 INFO - 'XPC_SERVICE_NAME': '0', 02:23:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:23:01 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 02:23:01 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 02:23:01 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 02:23:01 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 02:23:01 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 02:23:01 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 02:23:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:23:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:23:03 INFO - Installing collected packages: mozsystemmonitor 02:23:03 INFO - Running setup.py install for mozsystemmonitor 02:23:03 INFO - Successfully installed mozsystemmonitor 02:23:03 INFO - Cleaning up... 02:23:04 INFO - Return code: 0 02:23:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:23:04 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')]} 02:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:04 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')]} 02:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:04 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:04 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 02:23:04 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 02:23:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:04 INFO - 'HOME': '/Users/cltbld', 02:23:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:04 INFO - 'LOGNAME': 'cltbld', 02:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:04 INFO - 'MOZ_NO_REMOTE': '1', 02:23:04 INFO - 'NO_EM_RESTART': '1', 02:23:04 INFO - 'PAGER': '/bin/cat', 02:23:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:04 INFO - 'PWD': '/builds/slave/test', 02:23:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:04 INFO - 'SHELL': '/bin/bash', 02:23:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:04 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:04 INFO - 'USER': 'cltbld', 02:23:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:04 INFO - 'XPC_FLAGS': '0x0', 02:23:04 INFO - 'XPC_SERVICE_NAME': '0', 02:23:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:04 INFO - Downloading/unpacking jsonschema==2.5.1 02:23:04 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 02:23:04 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 02:23:04 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 02:23:04 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 02:23:04 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 02:23:04 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 02:23:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:07 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:07 INFO - warning: no files found matching '*.txt' 02:23:07 INFO - no previously-included directories found matching 'build' 02:23:07 INFO - no previously-included directories found matching 'dist' 02:23:07 INFO - no previously-included directories found matching '.git*' 02:23:07 INFO - Installing collected packages: jsonschema, functools32 02:23:07 INFO - Running setup.py install for functools32 02:23:07 INFO - warning: no files found matching '*.txt' 02:23:07 INFO - no previously-included directories found matching 'build' 02:23:07 INFO - no previously-included directories found matching 'dist' 02:23:07 INFO - no previously-included directories found matching '.git*' 02:23:07 INFO - Successfully installed jsonschema functools32 02:23:07 INFO - Cleaning up... 02:23:07 INFO - Return code: 0 02:23:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:07 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:07 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 02:23:07 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 02:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:07 INFO - 'HOME': '/Users/cltbld', 02:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:07 INFO - 'LOGNAME': 'cltbld', 02:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:07 INFO - 'MOZ_NO_REMOTE': '1', 02:23:07 INFO - 'NO_EM_RESTART': '1', 02:23:07 INFO - 'PAGER': '/bin/cat', 02:23:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:07 INFO - 'PWD': '/builds/slave/test', 02:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:07 INFO - 'SHELL': '/bin/bash', 02:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:07 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:07 INFO - 'USER': 'cltbld', 02:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:07 INFO - 'XPC_FLAGS': '0x0', 02:23:07 INFO - 'XPC_SERVICE_NAME': '0', 02:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:23:07 INFO - Cleaning up... 02:23:07 INFO - Return code: 0 02:23:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:23: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')]} 02:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:07 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:07 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 02:23:07 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 02:23:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:07 INFO - 'HOME': '/Users/cltbld', 02:23:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:07 INFO - 'LOGNAME': 'cltbld', 02:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:07 INFO - 'MOZ_NO_REMOTE': '1', 02:23:07 INFO - 'NO_EM_RESTART': '1', 02:23:07 INFO - 'PAGER': '/bin/cat', 02:23:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:07 INFO - 'PWD': '/builds/slave/test', 02:23:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:07 INFO - 'SHELL': '/bin/bash', 02:23:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:07 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:07 INFO - 'USER': 'cltbld', 02:23:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:07 INFO - 'XPC_FLAGS': '0x0', 02:23:07 INFO - 'XPC_SERVICE_NAME': '0', 02:23:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:08 INFO - Downloading/unpacking blobuploader==1.2.4 02:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:10 INFO - Downloading blobuploader-1.2.4.tar.gz 02:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:23:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:23:10 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 02:23:10 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 02:23:10 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 02:23:10 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 02:23:10 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 02:23:10 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 02:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:23:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:11 INFO - Downloading docopt-0.6.1.tar.gz 02:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:23:12 INFO - Installing collected packages: blobuploader, requests, docopt 02:23:12 INFO - Running setup.py install for blobuploader 02:23:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:23:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:23:12 INFO - Running setup.py install for requests 02:23:12 INFO - Running setup.py install for docopt 02:23:12 INFO - Successfully installed blobuploader requests docopt 02:23:12 INFO - Cleaning up... 02:23:12 INFO - Return code: 0 02:23:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:12 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:12 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 02:23:12 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 02:23:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:12 INFO - 'HOME': '/Users/cltbld', 02:23:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:12 INFO - 'LOGNAME': 'cltbld', 02:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:12 INFO - 'MOZ_NO_REMOTE': '1', 02:23:12 INFO - 'NO_EM_RESTART': '1', 02:23:12 INFO - 'PAGER': '/bin/cat', 02:23:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:12 INFO - 'PWD': '/builds/slave/test', 02:23:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:12 INFO - 'SHELL': '/bin/bash', 02:23:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:12 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:12 INFO - 'USER': 'cltbld', 02:23:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:12 INFO - 'XPC_FLAGS': '0x0', 02:23:12 INFO - 'XPC_SERVICE_NAME': '0', 02:23:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-btwfO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Izpn_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-voybna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-X0JWCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-x70bL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-f9Qeaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-uvhHXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:13 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ywjuKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-sbfvlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-4YJFWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Q8EigJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Olvx2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-JKwezM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-vvuEwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-GDNsVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1l1_j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:14 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BIXYvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:14 INFO - Running setup.py install for manifestparser 02:23:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:23:15 INFO - Running setup.py install for mozcrash 02:23:15 INFO - Running setup.py install for mozdebug 02:23:15 INFO - Running setup.py install for mozdevice 02:23:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:23:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:23:15 INFO - Running setup.py install for mozfile 02:23:15 INFO - Running setup.py install for mozhttpd 02:23:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:23:15 INFO - Running setup.py install for mozinfo 02:23:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:23:15 INFO - Running setup.py install for mozInstall 02:23:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Running setup.py install for mozleak 02:23:16 INFO - Running setup.py install for mozlog 02:23:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Running setup.py install for moznetwork 02:23:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Running setup.py install for mozprocess 02:23:16 INFO - Running setup.py install for mozprofile 02:23:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:23:16 INFO - Running setup.py install for mozrunner 02:23:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:23:17 INFO - Running setup.py install for mozscreenshot 02:23:17 INFO - Running setup.py install for moztest 02:23:17 INFO - Running setup.py install for mozversion 02:23:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:23:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:17 INFO - Cleaning up... 02:23:17 INFO - Return code: 0 02:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:17 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:17 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 02:23:17 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 02:23:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:17 INFO - 'HOME': '/Users/cltbld', 02:23:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:17 INFO - 'LOGNAME': 'cltbld', 02:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:17 INFO - 'MOZ_NO_REMOTE': '1', 02:23:17 INFO - 'NO_EM_RESTART': '1', 02:23:17 INFO - 'PAGER': '/bin/cat', 02:23:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:17 INFO - 'PWD': '/builds/slave/test', 02:23:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:17 INFO - 'SHELL': '/bin/bash', 02:23:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:17 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:17 INFO - 'USER': 'cltbld', 02:23:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:17 INFO - 'XPC_FLAGS': '0x0', 02:23:17 INFO - 'XPC_SERVICE_NAME': '0', 02:23:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:23:17 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-1817DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:23:17 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)) 02:23:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:23:17 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-JuXZ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-9Z1r1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-r2X7G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-BcC2hM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-A9DuHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-NtR6PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-tKoMnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-6jF4ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-ycDsr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:23:18 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-vnhmJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:23:18 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)) 02:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:23:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7QUopI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:23:19 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)) 02:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:23:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-7U9e0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:23:19 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)) 02:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:23:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-B0EGWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:23:19 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)) 02:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-Ny8hOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:23:19 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)) 02:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:23:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-DCncSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:23:19 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)) 02:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:23:19 INFO - Running setup.py (path:/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/pip-DWM4Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:23:19 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)) 02:23:19 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)) 02:23:19 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)) 02:23:19 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)) 02:23:19 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)) 02:23:19 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)) 02:23:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:19 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 02:23:19 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 02:23:19 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 02:23:19 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 02:23:19 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 02:23:19 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 02:23:22 INFO - Downloading blessings-1.6.tar.gz 02:23:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:22 INFO - Installing collected packages: blessings 02:23:22 INFO - Running setup.py install for blessings 02:23:22 INFO - Successfully installed blessings 02:23:22 INFO - Cleaning up... 02:23:22 INFO - Return code: 0 02:23:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:23:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:22 INFO - Reading from file tmpfile_stdout 02:23:22 INFO - Current package versions: 02:23:22 INFO - blessings == 1.6 02:23:22 INFO - blobuploader == 1.2.4 02:23:22 INFO - docopt == 0.6.1 02:23:22 INFO - functools32 == 3.2.3-2 02:23:22 INFO - jsonschema == 2.5.1 02:23:22 INFO - manifestparser == 1.1 02:23:22 INFO - mozInstall == 1.12 02:23:22 INFO - mozcrash == 1.0 02:23:22 INFO - mozdebug == 0.1 02:23:22 INFO - mozdevice == 0.48 02:23:22 INFO - mozfile == 1.2 02:23:22 INFO - mozhttpd == 0.7 02:23:22 INFO - mozinfo == 0.9 02:23:22 INFO - mozleak == 0.1 02:23:22 INFO - mozlog == 3.4 02:23:22 INFO - moznetwork == 0.27 02:23:22 INFO - mozprocess == 0.23 02:23:22 INFO - mozprofile == 0.28 02:23:22 INFO - mozrunner == 6.13 02:23:22 INFO - mozscreenshot == 0.1 02:23:22 INFO - mozsystemmonitor == 0.3 02:23:22 INFO - moztest == 0.7 02:23:22 INFO - mozversion == 1.4 02:23:22 INFO - psutil == 3.1.1 02:23:22 INFO - requests == 1.2.3 02:23:22 INFO - wsgiref == 0.1.2 02:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:22 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 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:22 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 02:23:22 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 02:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:22 INFO - 'HOME': '/Users/cltbld', 02:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:22 INFO - 'LOGNAME': 'cltbld', 02:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:22 INFO - 'MOZ_NO_REMOTE': '1', 02:23:22 INFO - 'NO_EM_RESTART': '1', 02:23:22 INFO - 'PAGER': '/bin/cat', 02:23:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:22 INFO - 'PWD': '/builds/slave/test', 02:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:22 INFO - 'SHELL': '/bin/bash', 02:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:22 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:22 INFO - 'USER': 'cltbld', 02:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:22 INFO - 'XPC_FLAGS': '0x0', 02:23:22 INFO - 'XPC_SERVICE_NAME': '0', 02:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 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)) 02:23:23 INFO - Cleaning up... 02:23:23 INFO - Return code: 0 02:23:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:23:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1066f4490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10666a570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b3adbfd50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, '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.BJgXfW7fQJ/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.p303yaThw8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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 02:23:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:23:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:23 INFO - 'HOME': '/Users/cltbld', 02:23:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:23 INFO - 'LOGNAME': 'cltbld', 02:23:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:23 INFO - 'MOZ_NO_REMOTE': '1', 02:23:23 INFO - 'NO_EM_RESTART': '1', 02:23:23 INFO - 'PAGER': '/bin/cat', 02:23:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:23 INFO - 'PWD': '/builds/slave/test', 02:23:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:23 INFO - 'SHELL': '/bin/bash', 02:23:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:23 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:23 INFO - 'USER': 'cltbld', 02:23:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:23 INFO - 'XPC_FLAGS': '0x0', 02:23:23 INFO - 'XPC_SERVICE_NAME': '0', 02:23:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:23:23 INFO - Cleaning up... 02:23:23 INFO - Return code: 0 02:23:23 INFO - Running post-action listener: _resource_record_post_action 02:23:23 INFO - Running post-action listener: _start_resource_monitoring 02:23:23 INFO - Starting resource monitoring. 02:23:23 INFO - [mozharness: 2016-12-07 10:23:23.505882Z] Finished create-virtualenv step (success) 02:23:23 INFO - [mozharness: 2016-12-07 10:23:23.506967Z] Running install step. 02:23:23 INFO - Running pre-action listener: _resource_record_pre_action 02:23:23 INFO - Running main action method: install 02:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:23:23 INFO - Reading from file tmpfile_stdout 02:23:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:23:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:23:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:23:23 INFO - Reading from file tmpfile_stdout 02:23:23 INFO - Output received: 02:23:23 INFO - Usage: mozinstall [options] installer 02:23:23 INFO - Options: 02:23:23 INFO - -h, --help show this help message and exit 02:23:23 INFO - -d DEST, --destination=DEST 02:23:23 INFO - Directory to install application into. [default: 02:23:23 INFO - "/builds/slave/test"] 02:23:23 INFO - --app=APP Application being installed. [default: firefox] 02:23:23 INFO - mkdir: /builds/slave/test/build/application 02:23:23 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'] 02:23:23 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 02:23:54 INFO - Reading from file tmpfile_stdout 02:23:54 INFO - Output received: 02:23:54 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:23:54 INFO - Running post-action listener: _resource_record_post_action 02:23:54 INFO - [mozharness: 2016-12-07 10:23:54.827404Z] Finished install step (success) 02:23:54 INFO - [mozharness: 2016-12-07 10:23:54.827555Z] Running run-tests step. 02:23:54 INFO - Running pre-action listener: _resource_record_pre_action 02:23:54 INFO - Running main action method: run_tests 02:23:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:23:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:23:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:23:54 INFO - 2016-12-07 02:23:54.842 screenresolution[1988:281892] starting screenresolution argv=screenresolution get 02:23:54 INFO - 2016-12-07 02:23:54.844 screenresolution[1988:281892] Display 0: 1600x1200x32@60 02:23:54 INFO - 2016-12-07 02:23:54.850 screenresolution[1989:281894] starting screenresolution argv=screenresolution list 02:23:54 INFO - Available Modes on Display 0 02:23:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:23:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:23:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:23:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:23:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:23:55 INFO - Intel Iris: 02:23:55 INFO - Chipset Model: Intel Iris 02:23:55 INFO - Type: GPU 02:23:55 INFO - Bus: Built-In 02:23:55 INFO - VRAM (Dynamic, Max): 1536 MB 02:23:55 INFO - Vendor: Intel (0x8086) 02:23:55 INFO - Device ID: 0x0a2e 02:23:55 INFO - Revision ID: 0x0009 02:23:55 INFO - Displays: 02:23:55 INFO - Display: 02:23:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:23:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:23:55 INFO - Display Serial Number: 1600x1200 60 02:23:55 INFO - Main Display: Yes 02:23:55 INFO - Mirror: Off 02:23:55 INFO - Online: Yes 02:23:55 INFO - Rotation: Supported 02:23:55 INFO - Return code: 0 02:23:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:23:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:23:55 INFO - Python 2.7.3 02:23:55 INFO - Return code: 0 02:23:55 INFO - grabbing minidump binary from tooltool 02:23: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')]} 02:23:55 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 0x106508d30>, '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 0x10636edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106500b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:23:55 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 02:23:55 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 02:23:55 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 02:23:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:23:55 INFO - Return code: 0 02:23:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:23:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:23:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:23:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:23:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:23:55 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/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 02:23:55 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/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0171 --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 02:23:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BJgXfW7fQJ/Render', 02:23:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:23:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:23:55 INFO - 'HOME': '/Users/cltbld', 02:23:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:23:55 INFO - 'LOGNAME': 'cltbld', 02:23:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:23:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:23:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:55 INFO - 'MOZ_NO_REMOTE': '1', 02:23:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:23:55 INFO - 'NO_EM_RESTART': '1', 02:23:55 INFO - 'PAGER': '/bin/cat', 02:23:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:23:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:23:55 INFO - 'PWD': '/builds/slave/test', 02:23:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:23:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:23:55 INFO - 'SHELL': '/bin/bash', 02:23:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.p303yaThw8/Listeners', 02:23:55 INFO - 'TMPDIR': '/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/', 02:23:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:23:55 INFO - 'USER': 'cltbld', 02:23:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:23:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:23:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:55 INFO - 'XPC_FLAGS': '0x0', 02:23:55 INFO - 'XPC_SERVICE_NAME': '0', 02:23:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:23:55 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/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0171', '--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 02:23:55 INFO - mozversion application_buildid: 20161207004003 02:23:55 INFO - mozversion application_changeset: 6c2cb17c6db341f49599522c4fb1350b7c37b9e0 02:23:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:23:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:23:55 INFO - mozversion application_name: Firefox 02:23:55 INFO - mozversion application_remotingname: firefox-dev 02:23:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:23:55 INFO - mozversion application_vendor: Mozilla 02:23:55 INFO - mozversion application_version: 52.0a2 02:23:55 INFO - mozversion platform_buildid: 20161207004003 02:23:55 INFO - mozversion platform_changeset: 6c2cb17c6db341f49599522c4fb1350b7c37b9e0 02:23:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:23:55 INFO - mozversion platform_version: 52.0a2 02:23:55 INFO - using testdate: 1481106235 02:23:55 INFO - actual date: 1481106235 02:23:55 INFO - starting webserver on 'localhost:49319' 02:23:55 INFO - SUITE-START | Running 2 tests 02:23:55 INFO - TEST-START | dromaeo_css 02:23:55 INFO - operating with platform_type : mac_ 02:23:55 INFO - Initialising browser for dromaeo_css test... 02:23:55 INFO - TEST-INFO | started process 2000 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpGaGg8a/profile http://localhost:49319/getInfo.html) 02:23:59 INFO - PROCESS | 2000 | 2016-12-07 02:23:59.123 plugin-container[2004:282211] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c57, name = 'com.apple.tsm.portname' 02:23:59 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:23:59 INFO - PROCESS | 2000 | 2016-12-07 02:23:59.124 plugin-container[2004:282211] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960f, name = 'com.apple.CFPasteboardClient' 02:23:59 INFO - PROCESS | 2000 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:23:59 INFO - PROCESS | 2000 | 2016-12-07 02:23:59.124 plugin-container[2004:282211] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:23:59 INFO - PROCESS | 2000 | __metrics Screen width/height:1600/1200 02:23:59 INFO - PROCESS | 2000 | colorDepth:24 02:23:59 INFO - PROCESS | 2000 | Browser inner width/height: 1024/689 02:23:59 INFO - PROCESS | 2000 | __metrics 02:23:59 ERROR - PROCESS | 2000 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:24:00 INFO - TEST-INFO | 2000: exit 0 02:24:00 INFO - Browser initialized. 02:24:00 INFO - Running cycle 1/1 for dromaeo_css test... 02:24:00 INFO - TEST-INFO | started process 2006 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpGaGg8a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:24:03 INFO - PROCESS | 2006 | 2016-12-07 02:24:03.216 plugin-container[2007:282343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 02:24:03 INFO - PROCESS | 2006 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:24:03 INFO - PROCESS | 2006 | 2016-12-07 02:24:03.216 plugin-container[2007:282343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 02:24:03 INFO - PROCESS | 2006 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:24:03 INFO - PROCESS | 2006 | 2016-12-07 02:24:03.216 plugin-container[2007:282343] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:24:12 INFO - PROCESS | 2006 | RSS: Main: 229613568 02:24:12 INFO - PROCESS | 2006 | 02:25:02 INFO - PROCESS | 2006 | 1481106302410 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] 02:27:16 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49319/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49319/tests/dromaeo/cssquery-ext.html) 02:27:19 INFO - PROCESS | 2006 | RSS: Main: 233504768 02:27:19 INFO - PROCESS | 2006 | 02:30:21 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49319/tests/dromaeo/cssquery-ext.html (next: http://localhost:49319/tests/dromaeo/cssquery-jquery.html) 02:30:22 INFO - PROCESS | 2006 | RSS: Main: 244047872 02:30:22 INFO - PROCESS | 2006 | 02:33:24 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49319/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49319/tests/dromaeo/cssquery-mootools.html) 02:33:24 INFO - PROCESS | 2006 | RSS: Main: 247103488 02:33:24 INFO - PROCESS | 2006 | 02:36:26 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49319/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49319/tests/dromaeo/cssquery-prototype.html) 02:36:27 INFO - PROCESS | 2006 | RSS: Main: 246378496 02:36:27 INFO - PROCESS | 2006 | 02:39:29 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49319/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49319/tests/dromaeo/cssquery-yui.html) 02:39:30 INFO - PROCESS | 2006 | RSS: Main: 250687488 02:39:30 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | Cycle 1(1): loaded http://localhost:49319/tests/dromaeo/cssquery-yui.html (next: http://localhost:49319/tests/dromaeo/cssquery-dojo.html) 02:42:33 INFO - PROCESS | 2006 | RSS: Main: 252043264 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | __start_tp_report 02:42:33 INFO - PROCESS | 2006 | _x_x_mozilla_page_load 02:42:33 INFO - PROCESS | 2006 | _x_x_mozilla_page_load_details 02:42:33 INFO - PROCESS | 2006 | |i|pagename|runs| 02:42:33 INFO - PROCESS | 2006 | |0;dojo.html;2794.4830206411802;3249.4638384666528;3395.4227781277195;3400.4559270516716;3405.4551271796486;5588.524975377088;5618.185363122345;5644.6613203207835;5731.914021289684;5757.136429535562;5664.461876121762;5750.309962804469;5763.308402991636;5791.391903850098;5804.100364443508;5206.349206349207;5219.269302297681;5279.340082489689;5305.867353316159;5348.117560602496;5226.973865130669;5285.709285989269;5327.840164795062;5336.252924590561;5389.245505629215;5122.718250496258;5201.427842937273;5205.3233079699585;5296.814611488579;5303.8408847734245;5230.633855630107;5237.319148510707;5240.397354304266;5249.186376111671;5254.7635356409055;4534.662274628992;4640.164770341337;5155.484451554852;5162.870928226786;5209.400918894337;4135.069609337905;4332.740035597874;5576.749046292926;5649.096144616883;5704.2299289595785;6168.814935551895;6184.536159788034;6238.594491358047;6245.125682404467;6259.37406259375;6080;6194.132821405007;6205.472534834545;6235.282942461629;6238.906416403757;5777.277840269966;5794.072948328248;5797.4782269595935;5802.767889284381;5834.387389324144;6331.873362532723;6344.746210151542;6363.395477429637;6366.267879193952;6371.808845734636;5078.263651770472;5562.888742225133;6163.3528479509905;6205.317415084427;6219.378062193835;5639.2668953035845;6128.092366597219;6171.660558669317;6171.9691401542705;6215.875682486416;6169.84575385619;6191.071339299051;6210.844728881814;6244.063390491372;6258.186435763321;6176.969115154486;6211.844703882349;6212.534059945522;6263.68681565929;6290;4134.37984302357;4748.738819364899;4825.517448255217;4894.339264199359;4989.276554899592;4380.342948557678;4416.9178551255145;4437.42313499243;4444.31113177458;4472.955270447319;5723.370429252779;5785.392533783976;5847.912281315784;5854.941450585525;5861.3552509223955;6090.482309003784;6181.474574661204;6268.122462855204;6271.78048768291;6281.591696539802;5669.716514174274;5705.7147142643535;5706.828795136153;5778.739956701958;5798.188253644493;5276.630635855453;5374.4625537445945;5392.218128371364;5394.568434525228;5413.998410294108;6240.4071613196675;6269.655168965751;6304.905426418516;6309.242890853127;6402.231732192166;4849.830255941025;6136.21274067861;6163.137160797582;6232.065190221503;6259.718312675849;6330.9870420734305;6333.20834895638;6367.490600752021;6384.297727250092;6386.233651961608;6178.9382106180165;6179.351168127461;6199.597026193283;6205.844853878689;6217.316095229611;6063.969680151571;6115.663638499926;6125.540584456095;6140.933729672948;6236.438720515175;5080.847574572768;5693.28833895763;6028.57799953999;6050.878982420415;6070.967935450895;6020.6989650516425;6058.12157237207;6062.818115456544;6062.909056364247;6100.389961003864;4903.31353610502;4989.625778066587;5217.530422262014;5832.562557808096;5894.764209431574;6050.515958723204;6062.454379105901;6064.545159113172;6071.028635418312;6081.422264884829;5939.990201665813;5955.404459554184;5964.612300200473;5968.955432799329;5969.403059693996 02:42:33 INFO - PROCESS | 2006 | |1;ext.html;444.93548435476856;479.2834712105403;520.310588470277;546.218906963043;552.878366759313;34713.47929781052;39845.4023189652;39919.201615967664;39974.60025399745;39976.20047599046;40194.995125121815;40614.18771624573;40731.79634101833;40820;40864;9176.770580735501;9347.158755711984;9416.058394160564;9416.905830941705;9442.669506567272;7776.53340799551;8939.821203575924;9320.673776417827;9423.575939082724;9428.528573571293;9487.28845336599;9492.477913714743;9496.335256532046;9541.33210675253;9547.474888881108;8143.714969976022;9086.591103400362;9398.718038458857;9472.289578281656;9519;7827.217278272127;9077.909220907772;9352.158305752515;9398.060193980615;9413.76465588359;39198.60801391978;39394;39477;39480.605193948264;39654.810355689086;3327.45097058985;3370.3933292007428;3523.2072783623735;3578.8389522471552;3833.926500579842;25286.124097952208;29857.10428687143;29971.850140749375;30372.544411833842;30570.08289751311;3175.6983086606733;3206.0542140068737;3209.326041531281;3239.222586579204;3280.6391296957318;456669;466296;467814.6609266966;468411;469429;61695;62135;62311.688441557504;62366.376336236965;62440.06339904905;62467;63235;64656.676716616115;64731.676341618935;64939;16012.839871601134;16260.918695406684;16262.512124636043;16266.83733162677;16316.75524867128;12202.450889709808;12457.1902826316;12463.439145238486;12524.74950500985;12546.87453125457;16558.586035349213;17600.29598816033;17857.910710446366;17883;17920.731189032176;6598.3401659833635;6610.4050635443045;6666.733310674297;6785.966070169717;6802.591844489347;848.4273115647037;952.8570714392896;1007.7027276953316;1010.7119470950744;1034.4414016431194;26978.325541861217;29796.40407191844;29839.403211935638;30238.84880575583;30324.54513182304;884.1026358246385;937.5359197197295;975.4732444480044;1019.0930072235716;1020.6733845169623;10568.735781605521;12426.378681066091;12659.556915507914;12705.047121465926;12767.17013394145;621204;627631;628421;629569.8521507363;630382;56775;56887;56992.71503642455;57095;57343;1352.5130952856964;1357.83705955286;1374.3815283122635;1380.1650001748797;1383.6955869708647;24387.14644987417;24771.88526516275;25045.99816007339;25112;25435.491290174465;46943;47967.52032479631;51355.2296715557;51463.48536514737;51476;577575;581208;583340;583925;585755;25311.620325695498;26365.20904372872;26725.732742672324;26772.464550708486;26786.33034174083;43886.56113438825;46135;46702;46836.06327873492;47235;31984.520232197003;37263.813680931424;37471.688490902685;37513;39188.23652935568;37779.43330849984;38089;38683.03292417712;38893.41659875161;38963.610363896;37319.25361492701;37407.625923740416;37518.24963500769;38033.4294985581;38365;33024.66975330216;34195.316093678484;34986.12534686653;35113.12217194488;35138;25657.615135772605;25756.742432576182;25979.83090760958;26111.477770444104;26220.8688956554 02:42:33 INFO - PROCESS | 2006 | |2;jquery.html;370.4239906944701;374.24402706532805;383.7869982159902;385.39877790646614;403.6347105869189;17793.644127117466;19047.23811047558;19226.327078552255;19428.41714748556;19507.5123121922;19892;19958.800411995875;20084.497887552818;20085.497862553442;20446.693299600516;4602.539746025404;5523.25436066131;5745.511631511326;5808.82573522795;5816.534677225812;5689.203511508392;5814.622049566765;5817.62185457946;5826.242588463494;5830.44610761979;5472.370677372113;5610.214569960209;5685.744141513642;5743.138529220609;5775.306963164426;5664;5673.234113394701;5703.31560212775;5707.315122185323;5712.600117991742;4926.852194434173;5020.945601423706;5205.401378841406;5208;5265.6840589564745;12766.680832979157;12995.155314904501;13026.478940842355;19863.30478433248;23680.526389472114;2200.99854566172;2257.7290725113094;2332.4635333873302;2797.062983900396;2904.12876137158;9758.560864761102;9967.45179015154;10013.949930250303;10153;10285.69142925706;1534.501287081703;1797.3170195325692;1827.4608990347747;1836.6234921841124;1904.64764018657;90113.64829527562;116438;119048.80951190378;120169.19746203814;122725.38637306845;11374.601888933848;11634.476448559835;11713.824292635618;11816.350100744541;11888.167828251939;11099.667009989713;13059.21644701321;13248.40382182804;14556.981011329317;14659.120452772868;7135.607541585263;8187.631556579968;8417.789555261168;8427.831443371098;8451.11263317355;8193.672253109928;8287.295579875657;8312.8753068704;8460.069392366835;8483.618237179342;4424.137293227854;4536.8638940831825;4567.2920697291975;4608.216603177468;4636.698614590041;1647.571631375851;1942.9222831086881;1960.5003620384125;1966.7344908437465;1984.9206031758856;787.9763607091796;874.0691163910415;895.9059298773535;925.1072714830221;940.8635747816666;18825.811741882408;20209.797902021084;20322.18711251563;20407.489812754502;20705.482362941046;891.3315013739696;937.668510714773;949.3971328206638;953.8903026151943;987.7382493639192;8671;10494.73763155912;10746.462676866126;10759.677209683721;10792.730181745519;585199;598999;609484;619981;622646.7735322589;90400;121055.39472302582;125943.74056259503;125969;126517.36741316234;971.8104969531015;973.0755782007263;1011.701548043329;1015.608990538648;1018.180364806338;15664.138472384127;16209;17979;18017.369392071738;18027.008514531826;34512.65487345094;52317;52620.736896316805;53791;54168.45831541634;71126.64436677784;73694.89457658032;74478;75111;75611.24388756041;7744.806379840549;7774.416918731004;7837.177096405024;8097.797555061171;8172.591370431336;10077.496125193858;12047;12084.75830483403;12385.133040687066;12420;8889.822203555763;10335.22485813552;10408.167346612405;10520.579176832842;10842.241043126905;9603.279754018336;9889.208863291064;10755.408452535186;10797.190210734383;10956.780864382508;9179;10714.946425267824;10788.892111078789;10852.782944340912;11211.383373914186;6629.668516574248;7866.881996769938;8033.879491807511;8098.3521318293215;8218.424710270463;10388.220883433622;10636.255462117888;10646.89353106459;10955.794862565272;11032.393218373067 02:42:33 INFO - PROCESS | 2006 | |3;mootools.html;1433.634423222078;1447.7683570628694;1493.6788590453054;1588.7140314743342;1824.7810262768462;6656.96671516643;7118.679659415319;7244.311790379912;7438.739644112457;7541.358984486312;8017.518948863058;8303.83392332153;8307.252347288742;8435.91564084359;8443.282321002707;1782.4028950301665;2059.855810093294;2131.79747923947;2334.6498025296255;2347.6713260143592;1932.3430033788509;2358.5047140100514;2391.0555330644384;2391.1630929174826;2391.306521108885;2317.0731707317123;2335.4161459635093;2335.5328934213226;2344.191254017361;2354.2466410748566;2044.7444069491314;2313.7223533176043;2351.024324905171;2352.6588644646604;2358.599038163508;2209.1826024370926;2230.4869879927546;2251.0995601759264;2257.6952111464907;2264.9547009059893;8375.748727538183;8415.495070295801;8428;8429.452085614477;8507.957460212721;4096.426500289962;5183.740812959337;5185.507376799198;5192.584593232532;5203.999999999962;2967.8219306841656;3179.9205019874457;3318.568586083818;3324.6010478742464;3340.3486320167576;1036.3263878478974;1058.3226734889677;1078.7934520896035;1085.3976043295968;1098.5166526728215;8968.282537396992;10595.682129536126;10995.560177592886;11051.834222486668;11058.557657693682;4537.3647689323525;4653.744044077541;4753.714777113384;4771.23660214364;4771.9522804772205;9505.239580833517;9559.330846840654;9563.09150630689;9584.233261339075;9586.66446674363;5217;5265.631405801634;5269.446708095671;5273.525382715574;5277.2875661785165;3474.722022238215;4291.570842915746;4432.578905004019;4532.116237333754;4766.880827979328;3372.4772660237704;3854.383298672199;3890.6109389061435;3893.707971902062;3976.1848820992204;1098.5441041967495;1276.814861845046;1277.2272774971009;1277.6231011851526;1294.9028822838325;760.5094713909608;841.1714461255658;903.7243640689521;917.1607978699549;934.8831396075491;5565.749541270652;5579.358373787067;5709.200711900337;5723.570732195102;5886.735096920649;370.9128354836611;381.13672531715684;429.32167175862065;437.2195630799072;438.53296239504823;3256.886008989674;3743.3823419136083;3808.9428658570146;3815.5802861685193;3834.175652234783;9773.413595184169;10024.348417352849;10170.389776613427;10177.134943529734;10218.897811021943;9699.757506062264;9915.702528924145;10127.797444051224;10129.949350253202;10173.949130254301;7530.171681115073;7855.37157027425;7859.882101768478;7865.685372585147;7892.684292628345;5494.340679118372;5500.642458240201;5528.9447105530035;5590.748416321357;5655.604107712421;9252.583633736633;9267.582958766738;9381.249500039843;9433.481158536346;9477.336586439158;9324.627014919599;9521.143097121292;9536.666216682383;9596.808063838544;9673.854892176481;6059.606125601822;6594.175728033996;6817.284185160487;7044.330788575077;7248.311410416002;7829.217078292125;8053.758387248392;8066.435349525477;8067.677292908453;8069.919300806917;7075.540089894141;7077.858442831218;7242.3843973262865;7242.818929526804;7385.9630701846145;6914.343137401939;7072.398846098139;7160.7493737721015;7161.4270858330165;7200.819979500555;6619.271880093283;6774.3225677431865;6777.2883847195335;6787.524873258824;6788.524803263724;4516.977415112903;4581.473130590025;4656.1851675955895;4671.906561868812;4803.855884323476;4812.109759694467;4826.444958829639;4869.415670119608;4997.150484417585;5059.721715305694 02:42:33 INFO - PROCESS | 2006 | |4;prototype.html;293.54940166843886;302.1449298485286;311.62883313420946;311.98908038218667;315.64962891190777;4897.730624815634;5391.541718953888;5453.890922181554;5484.875600501892;5556.555475561955;4539.568740969611;4688.484266730666;4951.237059834525;5332.386775520817;5391.56867450604;3113.972389111599;3610.421898167338;3838.405047217686;4066.5933406659246;4210.073783767566;4090.3455447128467;4110.020235329393;4111.403846442264;4257.638100761439;4263.211305908401;3500.457429098494;3786.091338078855;4119.876403707894;4150.356694712309;4158.584141585848;3713.9786558696305;4081.0613558881328;4083.5099788025477;4114.321137012389;4139.405260161234;3012.623422072241;3049.2072061264007;3581.982090089533;3609.9819500902327;3622.800745958971;3860.4595356650093;4913.484084171182;4920.680155789898;5292.708901010443;5353.1167357386375;3925.960740392588;4451.799669014869;4695.577398034194;4703.965127671907;4745.288206768978;4691.859244222679;4761.738104404257;5729.684867332295;5757.539396848242;5770.932377510174;3685.5208822852856;3870.3033453978273;3881.825317860703;3882.747621404628;3887.747296425723;4584.166333466606;5065.8733531662;5679.943200568024;5965.105234214859;6053.969730151365;3706.9073273167846;3911.3155197840265;3923.8234279456924;3942.250972315251;3970.82131304092;3489.45913383426;3793;3999.200159968018;4005.1989602079702;4011.398290256485;3791.7724936503346;4105.378375541644;4629.120467111238;4660.790264438108;4685.882852928704;5237.240600112962;5316.9202461963105;5792.710364481759;5803.245578074823;5821.970890145522;1236.5594082893329;1262.1417436143327;1266.5883587833991;1268.302433661501;1296.4749276543016;760.6919197724931;860.870869369587;868.900076491199;882.5366682491743;882.8763973043779;4950.950490495121;4976.556798528386;5045.84862454127;5070.239464080418;5078.619103567247;4957.984032933264;5265.894682106336;5572.498475137257;5572.58205634579;5611.7755289788765;4065;4985.351904252424;5018.737820416758;5097.796088156507;5107.948920510822;2431.610942249232;2798;2996.3258266889775;3002.6338016202576;3027;5715.342735585377;5819.127130930309;5833.154192642043;5884.382139875252;5903.734331954986;5426.178387238614;5457.426970168154;5654.547636189095;5742;5804.593678442468;5322.654027488278;5875.11873219012;5893.554175017405;5934.347221805598;5983;4844.46710861812;4905.23968784839;5667.263255776723;5709.286339207599;5752.568557358299;5031.74841257943;5175.404828444626;5627.352854421631;5648.8763202862965;5681.068436731531;5057.216131499624;5237.685738855681;5486.369067557282;6002.679410529677;6038.245219347582;3381.630439671937;3487.9651203488656;3723.6648701616987;3775.5469343678933;3790.981045094867;5060.355384499979;5376.73116344189;5591.161325801162;5605.020435490847;5674.801381951612;4993.550580447777;5020.196768517019;5565.805196818092;5654.886902262014;5678.403767604507;5338.919916201183;5512.503874651301;5591.27313449249;5711.143328500758;5719.5138413235345;4716.740579268173;5276.868078298074;5543.52880005204;5566.415526369673;5596.356419011866;4777.617790576815;5640.548756099584;5653.180288858175;5695.629784064023;5727.341355743976;4715.019691729413;5520.806771762969;5574.749136288796;5590.608657393944;5627.8874422512135 02:42:33 INFO - PROCESS | 2006 | |5;yui.html;597.7340083662771;684.4626967830254;693.334398976982;726.9600171990542;755.7619349904779;14068.366923488442;14814.851851481482;14921.477748278812;14922.626934326647;14947.476838310662;13241.867581324184;13313.866861331384;13431.328433578306;13584.524541641045;13585.049046566744;813.2314962360572;824.9752507424787;830.2818062376061;832.7585000349891;836.4061516323387;818.3207937411963;825.331481499984;831;831.9625616847226;833.6248688090384;817.7424111404888;817.7832874288289;843.359047124187;861.7974775927652;864.2437866866492;829.8921140251789;854.7264875239895;860.711661593367;861.8405594964889;862.1421685423044;622.6419808610067;624.9531285153631;632.0708558419117;637.3339859846471;640.3468462168562;12420.192687475375;12542.1847579907;12545.560905368267;12724.236545807282;13815.378307976065;12886.742265154739;13398;13464.932675336659;13516.986226032988;13565.389557469938;11147.888521114848;11231.455627651829;11414.972652461236;11440;11615.767684646344;3439.7420193485586;3458.3774920514297;3461.359648465017;3464.4110501214855;3473.0969947813496;89995;90129.09870901273;90765.54617226937;91064;91111.54444227736;10069.59721611142;10346.689599312032;10415.68752937413;10438.68683939483;10453.581856725647;20065.799342006685;20069.39791806248;20088.49778755543;20145.496362591053;20222.898885505478;7558.168601453835;7586.127595326498;7608.2391760823475;7623.656935437919;7650.2349765023055;4210.368444733253;4215.356651552706;4224.55642157569;4291.849785257501;4375.496817865923;3010.1270631517054;3362.125847279676;3419.6067452242814;3485.808280544544;3486.442169252907;537.9912663755458;558.3913534247608;621.564904566805;630.5680608782999;665.3180489997791;598.751518119984;641.6599202422724;661.6923130744227;662.5660192573872;663.4460225711584;8687.391882568287;9073.91486894459;9221.077892210726;9415.293852960918;9923;633.9603050996369;645.7675236914707;660.798456470781;670.778643047793;708.348319546019;4123.278426275389;4275.3800698898485;4377.387165796791;4399.64802815774;4502.279635258343;106158;107322.9267707313;107428.46285768677;107729;110712.33931491034;74374;78003.60998194973;80035.79051551344;81149.18850811417;89749.99999999869;55021.44978550243;56868.43131568714;57430;60735.78528429407;69543;9390.624375024923;9581.185599224144;9612.567434465325;9907;9924.553395097093;48036.279455808886;49783.751081244365;50798.23802643037;51410.74294628503;53623.65940851354;68344.6582767083;72067.63966180135;73272.53454930978;73685.6315718418;74545.6272718633;12266.509339626315;12327.383630818602;12510.789033851519;12540.87459125397;12680.112392132462;14052.718945620825;14130.646733831325;14161.716765664423;14335.784963225351;14362.784558231426;12268.631941041784;12963.611091667264;12971.1894894804;13414.865851341361;13911.234882081582;12984.935075324564;13090.869091308965;13454;13529.391177396845;13809.861901380858;12893.290869002294;12936.223826570436;12966.351682415652;13200.405981730653;13243.20540767557;8798.824023519623;10964.835527466936;11237.550497980315;11563.479643415898;11567.537298508301;9312.34813563044;11359;11439.828402574134;11451.942740286246;11531 02:42:33 INFO - PROCESS | 2006 | __end_tp_report 02:42:33 INFO - PROCESS | 2006 | __start_cc_report 02:42:33 INFO - PROCESS | 2006 | _x_x_mozilla_cycle_collect,373 02:42:33 INFO - PROCESS | 2006 | __end_cc_report 02:42:33 INFO - PROCESS | 2006 | __startTimestamp1481107353393__endTimestamp 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | ------- Summary: start ------- 02:42:33 INFO - PROCESS | 2006 | Number of tests: 6 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | [#0] dojo.html Cycles:165 Average:5670.29 Median:5847.91 stddev:691.77 (11.8%) stddev-sans-first:656.07 02:42:33 INFO - PROCESS | 2006 | Values: 2794.5 3249.5 3395.4 3400.5 3405.5 5588.5 5618.2 5644.7 5731.9 5757.1 5664.5 5750.3 5763.3 5791.4 5804.1 5206.3 5219.3 5279.3 5305.9 5348.1 5227.0 5285.7 5327.8 5336.3 5389.2 5122.7 5201.4 5205.3 5296.8 5303.8 5230.6 5237.3 5240.4 5249.2 5254.8 4534.7 4640.2 5155.5 5162.9 5209.4 4135.1 4332.7 5576.7 5649.1 5704.2 6168.8 6184.5 6238.6 6245.1 6259.4 6080.0 6194.1 6205.5 6235.3 6238.9 5777.3 5794.1 5797.5 5802.8 5834.4 6331.9 6344.7 6363.4 6366.3 6371.8 5078.3 5562.9 6163.4 6205.3 6219.4 5639.3 6128.1 6171.7 6172.0 6215.9 6169.8 6191.1 6210.8 6244.1 6258.2 6177.0 6211.8 6212.5 6263.7 6290.0 4134.4 4748.7 4825.5 4894.3 4989.3 4380.3 4416.9 4437.4 4444.3 4473.0 5723.4 5785.4 5847.9 5854.9 5861.4 6090.5 6181.5 6268.1 6271.8 6281.6 5669.7 5705.7 5706.8 5778.7 5798.2 5276.6 5374.5 5392.2 5394.6 5414.0 6240.4 6269.7 6304.9 6309.2 6402.2 4849.8 6136.2 6163.1 6232.1 6259.7 6331.0 6333.2 6367.5 6384.3 6386.2 6178.9 6179.4 6199.6 6205.8 6217.3 6064.0 6115.7 6125.5 6140.9 6236.4 5080.8 5693.3 6028.6 6050.9 6071.0 6020.7 6058.1 6062.8 6062.9 6100.4 4903.3 4989.6 5217.5 5832.6 5894.8 6050.5 6062.5 6064.5 6071.0 6081.4 5940.0 5955.4 5964.6 5969.0 5969.4 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | [#1] ext.html Cycles:180 Average:68853.68 Median:39750.11 stddev:150436.41 (378.5%) stddev-sans-first:150770.75 02:42:33 INFO - PROCESS | 2006 | Values: 444.9 479.3 520.3 546.2 552.9 34713.5 39845.4 39919.2 39974.6 39976.2 40195.0 40614.2 40731.8 40820.0 40864.0 9176.8 9347.2 9416.1 9416.9 9442.7 7776.5 8939.8 9320.7 9423.6 9428.5 9487.3 9492.5 9496.3 9541.3 9547.5 8143.7 9086.6 9398.7 9472.3 9519.0 7827.2 9077.9 9352.2 9398.1 9413.8 39198.6 39394.0 39477.0 39480.6 39654.8 3327.5 3370.4 3523.2 3578.8 3833.9 25286.1 29857.1 29971.9 30372.5 30570.1 3175.7 3206.1 3209.3 3239.2 3280.6 456669.0 466296.0 467814.7 468411.0 469429.0 61695.0 62135.0 62311.7 62366.4 62440.1 62467.0 63235.0 64656.7 64731.7 64939.0 16012.8 16260.9 16262.5 16266.8 16316.8 12202.5 12457.2 12463.4 12524.7 12546.9 16558.6 17600.3 17857.9 17883.0 17920.7 6598.3 6610.4 6666.7 6786.0 6802.6 848.4 952.9 1007.7 1010.7 1034.4 26978.3 29796.4 29839.4 30238.8 30324.5 884.1 937.5 975.5 1019.1 1020.7 10568.7 12426.4 12659.6 12705.0 12767.2 621204.0 627631.0 628421.0 629569.9 630382.0 56775.0 56887.0 56992.7 57095.0 57343.0 1352.5 1357.8 1374.4 1380.2 1383.7 24387.1 24771.9 25046.0 25112.0 25435.5 46943.0 47967.5 51355.2 51463.5 51476.0 577575.0 581208.0 583340.0 583925.0 585755.0 25311.6 26365.2 26725.7 26772.5 26786.3 43886.6 46135.0 46702.0 46836.1 47235.0 31984.5 37263.8 37471.7 37513.0 39188.2 37779.4 38089.0 38683.0 38893.4 38963.6 37319.3 37407.6 37518.2 38033.4 38365.0 33024.7 34195.3 34986.1 35113.1 35138.0 25657.6 25756.7 25979.8 26111.5 26220.9 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | [#2] jquery.html Cycles:180 Average:34115.59 Median:372.33 stddev:101047.28 (27138.9%) stddev-sans-first:101298.98 02:42:33 INFO - PROCESS | 2006 | Values: 370.4 374.2 383.8 385.4 403.6 17793.6 19047.2 19226.3 19428.4 19507.5 19892.0 19958.8 20084.5 20085.5 20446.7 4602.5 5523.3 5745.5 5808.8 5816.5 5689.2 5814.6 5817.6 5826.2 5830.4 5472.4 5610.2 5685.7 5743.1 5775.3 5664.0 5673.2 5703.3 5707.3 5712.6 4926.9 5020.9 5205.4 5208.0 5265.7 12766.7 12995.2 13026.5 19863.3 23680.5 2201.0 2257.7 2332.5 2797.1 2904.1 9758.6 9967.5 10013.9 10153.0 10285.7 1534.5 1797.3 1827.5 1836.6 1904.6 90113.6 116438.0 119048.8 120169.2 122725.4 11374.6 11634.5 11713.8 11816.4 11888.2 11099.7 13059.2 13248.4 14557.0 14659.1 7135.6 8187.6 8417.8 8427.8 8451.1 8193.7 8287.3 8312.9 8460.1 8483.6 4424.1 4536.9 4567.3 4608.2 4636.7 1647.6 1942.9 1960.5 1966.7 1984.9 788.0 874.1 895.9 925.1 940.9 18825.8 20209.8 20322.2 20407.5 20705.5 891.3 937.7 949.4 953.9 987.7 8671.0 10494.7 10746.5 10759.7 10792.7 585199.0 598999.0 609484.0 619981.0 622646.8 90400.0 121055.4 125943.7 125969.0 126517.4 971.8 973.1 1011.7 1015.6 1018.2 15664.1 16209.0 17979.0 18017.4 18027.0 34512.7 52317.0 52620.7 53791.0 54168.5 71126.6 73694.9 74478.0 75111.0 75611.2 7744.8 7774.4 7837.2 8097.8 8172.6 10077.5 12047.0 12084.8 12385.1 12420.0 8889.8 10335.2 10408.2 10520.6 10842.2 9603.3 9889.2 10755.4 10797.2 10956.8 9179.0 10714.9 10788.9 10852.8 11211.4 6629.7 7866.9 8033.9 8098.4 8218.4 10388.2 10636.3 10646.9 10955.8 11032.4 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | [#3] mootools.html Cycles:180 Average:5384.06 Median:5028.44 stddev:3004.13 (59.7%) stddev-sans-first:2997.89 02:42:33 INFO - PROCESS | 2006 | Values: 1433.6 1447.8 1493.7 1588.7 1824.8 6657.0 7118.7 7244.3 7438.7 7541.4 8017.5 8303.8 8307.3 8435.9 8443.3 1782.4 2059.9 2131.8 2334.6 2347.7 1932.3 2358.5 2391.1 2391.2 2391.3 2317.1 2335.4 2335.5 2344.2 2354.2 2044.7 2313.7 2351.0 2352.7 2358.6 2209.2 2230.5 2251.1 2257.7 2265.0 8375.7 8415.5 8428.0 8429.5 8508.0 4096.4 5183.7 5185.5 5192.6 5204.0 2967.8 3179.9 3318.6 3324.6 3340.3 1036.3 1058.3 1078.8 1085.4 1098.5 8968.3 10595.7 10995.6 11051.8 11058.6 4537.4 4653.7 4753.7 4771.2 4772.0 9505.2 9559.3 9563.1 9584.2 9586.7 5217.0 5265.6 5269.4 5273.5 5277.3 3474.7 4291.6 4432.6 4532.1 4766.9 3372.5 3854.4 3890.6 3893.7 3976.2 1098.5 1276.8 1277.2 1277.6 1294.9 760.5 841.2 903.7 917.2 934.9 5565.7 5579.4 5709.2 5723.6 5886.7 370.9 381.1 429.3 437.2 438.5 3256.9 3743.4 3808.9 3815.6 3834.2 9773.4 10024.3 10170.4 10177.1 10218.9 9699.8 9915.7 10127.8 10129.9 10173.9 7530.2 7855.4 7859.9 7865.7 7892.7 5494.3 5500.6 5528.9 5590.7 5655.6 9252.6 9267.6 9381.2 9433.5 9477.3 9324.6 9521.1 9536.7 9596.8 9673.9 6059.6 6594.2 6817.3 7044.3 7248.3 7829.2 8053.8 8066.4 8067.7 8069.9 7075.5 7077.9 7242.4 7242.8 7386.0 6914.3 7072.4 7160.7 7161.4 7200.8 6619.3 6774.3 6777.3 6787.5 6788.5 4517.0 4581.5 4656.2 4671.9 4803.9 4812.1 4826.4 4869.4 4997.2 5059.7 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | [#4] prototype.html Cycles:180 Average:4495.34 Median:5006.14 stddev:1393.75 (27.8%) stddev-sans-first:1361.51 02:42:33 INFO - PROCESS | 2006 | Values: 293.5 302.1 311.6 312.0 315.6 4897.7 5391.5 5453.9 5484.9 5556.6 4539.6 4688.5 4951.2 5332.4 5391.6 3114.0 3610.4 3838.4 4066.6 4210.1 4090.3 4110.0 4111.4 4257.6 4263.2 3500.5 3786.1 4119.9 4150.4 4158.6 3714.0 4081.1 4083.5 4114.3 4139.4 3012.6 3049.2 3582.0 3610.0 3622.8 3860.5 4913.5 4920.7 5292.7 5353.1 3926.0 4451.8 4695.6 4704.0 4745.3 4691.9 4761.7 5729.7 5757.5 5770.9 3685.5 3870.3 3881.8 3882.7 3887.7 4584.2 5065.9 5679.9 5965.1 6054.0 3706.9 3911.3 3923.8 3942.3 3970.8 3489.5 3793.0 3999.2 4005.2 4011.4 3791.8 4105.4 4629.1 4660.8 4685.9 5237.2 5316.9 5792.7 5803.2 5822.0 1236.6 1262.1 1266.6 1268.3 1296.5 760.7 860.9 868.9 882.5 882.9 4951.0 4976.6 5045.8 5070.2 5078.6 4958.0 5265.9 5572.5 5572.6 5611.8 4065.0 4985.4 5018.7 5097.8 5107.9 2431.6 2798.0 2996.3 3002.6 3027.0 5715.3 5819.1 5833.2 5884.4 5903.7 5426.2 5457.4 5654.5 5742.0 5804.6 5322.7 5875.1 5893.6 5934.3 5983.0 4844.5 4905.2 5667.3 5709.3 5752.6 5031.7 5175.4 5627.4 5648.9 5681.1 5057.2 5237.7 5486.4 6002.7 6038.2 3381.6 3488.0 3723.7 3775.5 3791.0 5060.4 5376.7 5591.2 5605.0 5674.8 4993.6 5020.2 5565.8 5654.9 5678.4 5338.9 5512.5 5591.3 5711.1 5719.5 4716.7 5276.9 5543.5 5566.4 5596.4 4777.6 5640.5 5653.2 5695.6 5727.3 4715.0 5520.8 5574.7 5590.6 5627.9 02:42:33 INFO - PROCESS | 2006 | 02:42:33 INFO - PROCESS | 2006 | [#5] yui.html Cycles:180 Average:19304.20 Median:4388.52 stddev:27567.96 (628.2%) stddev-sans-first:27609.51 02:42:33 INFO - PROCESS | 2006 | Values: 597.7 684.5 693.3 727.0 755.8 14068.4 14814.9 14921.5 14922.6 14947.5 13241.9 13313.9 13431.3 13584.5 13585.0 813.2 825.0 830.3 832.8 836.4 818.3 825.3 831.0 832.0 833.6 817.7 817.8 843.4 861.8 864.2 829.9 854.7 860.7 861.8 862.1 622.6 625.0 632.1 637.3 640.3 12420.2 12542.2 12545.6 12724.2 13815.4 12886.7 13398.0 13464.9 13517.0 13565.4 11147.9 11231.5 11415.0 11440.0 11615.8 3439.7 3458.4 3461.4 3464.4 3473.1 89995.0 90129.1 90765.5 91064.0 91111.5 10069.6 10346.7 10415.7 10438.7 10453.6 20065.8 20069.4 20088.5 20145.5 20222.9 7558.2 7586.1 7608.2 7623.7 7650.2 4210.4 4215.4 4224.6 4291.8 4375.5 3010.1 3362.1 3419.6 3485.8 3486.4 538.0 558.4 621.6 630.6 665.3 598.8 641.7 661.7 662.6 663.4 8687.4 9073.9 9221.1 9415.3 9923.0 634.0 645.8 660.8 670.8 708.3 4123.3 4275.4 4377.4 4399.6 4502.3 106158.0 107322.9 107428.5 107729.0 110712.3 74374.0 78003.6 80035.8 81149.2 89750.0 55021.4 56868.4 57430.0 60735.8 69543.0 9390.6 9581.2 9612.6 9907.0 9924.6 48036.3 49783.8 50798.2 51410.7 53623.7 68344.7 72067.6 73272.5 73685.6 74545.6 12266.5 12327.4 12510.8 12540.9 12680.1 14052.7 14130.6 14161.7 14335.8 14362.8 12268.6 12963.6 12971.2 13414.9 13911.2 12984.9 13090.9 13454.0 13529.4 13809.9 12893.3 12936.2 12966.4 13200.4 13243.2 8798.8 10964.8 11237.6 11563.5 11567.5 9312.3 11359.0 11439.8 11451.9 11531.0 02:42:33 INFO - PROCESS | 2006 | -------- Summary: end -------- 02:42:33 INFO - PROCESS | 2006 | 02:42:34 INFO - TEST-INFO | 2006: exit 0 02:42:34 INFO - TEST-OK | dromaeo_css | took 1118591ms 02:42:34 INFO - TEST-START | kraken 02:42:34 INFO - operating with platform_type : mac_ 02:42:34 INFO - Initialising browser for kraken test... 02:42:34 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpjBfd3_/profile http://localhost:49319/getInfo.html) 02:42:37 INFO - PROCESS | 2013 | 2016-12-07 02:42:37.073 plugin-container[2015:284508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443f, name = 'com.apple.tsm.portname' 02:42:37 INFO - PROCESS | 2013 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:37 INFO - PROCESS | 2013 | 2016-12-07 02:42:37.073 plugin-container[2015:284508] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 02:42:37 INFO - PROCESS | 2013 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:37 INFO - PROCESS | 2013 | 2016-12-07 02:42:37.073 plugin-container[2015:284508] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:42:37 INFO - PROCESS | 2013 | __metrics Screen width/height:1600/1200 02:42:37 INFO - PROCESS | 2013 | colorDepth:24 02:42:37 INFO - PROCESS | 2013 | Browser inner width/height: 1024/689 02:42:37 INFO - PROCESS | 2013 | __metrics 02:42:37 ERROR - PROCESS | 2013 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 02:42:38 INFO - TEST-INFO | 2013: exit 0 02:42:38 INFO - Browser initialized. 02:42:38 INFO - Running cycle 1/1 for kraken test... 02:42:38 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/T/tmpjBfd3_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:42:40 INFO - PROCESS | 2016 | 2016-12-07 02:42:40.766 plugin-container[2017:284633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 02:42:40 INFO - PROCESS | 2016 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:40 INFO - PROCESS | 2016 | 2016-12-07 02:42:40.766 plugin-container[2017:284633] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 02:42:40 INFO - PROCESS | 2016 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:42:40 INFO - PROCESS | 2016 | 2016-12-07 02:42:40.766 plugin-container[2017:284633] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:42:50 INFO - PROCESS | 2016 | RSS: Main: 229658624 02:42:50 INFO - PROCESS | 2016 | 02:42:53 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49319/tests/kraken/driver.html?testName=audio-beat-detection) 02:42:54 INFO - PROCESS | 2016 | RSS: Main: 241659904 02:42:54 INFO - PROCESS | 2016 | 02:42:56 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49319/tests/kraken/driver.html?testName=audio-dft) 02:42:57 INFO - PROCESS | 2016 | RSS: Main: 249249792 02:42:57 INFO - PROCESS | 2016 | 02:43:00 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49319/tests/kraken/driver.html?testName=audio-fft) 02:43:01 INFO - PROCESS | 2016 | RSS: Main: 252940288 02:43:01 INFO - PROCESS | 2016 | 02:43:03 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49319/tests/kraken/driver.html?testName=audio-oscillator) 02:43:03 INFO - PROCESS | 2016 | RSS: Main: 254435328 02:43:03 INFO - PROCESS | 2016 | 02:43:05 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49319/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:06 INFO - PROCESS | 2016 | RSS: Main: 254332928 02:43:06 INFO - PROCESS | 2016 | 02:43:09 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49319/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:09 INFO - PROCESS | 2016 | RSS: Main: 259092480 02:43:09 INFO - PROCESS | 2016 | 02:43:12 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49319/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:13 INFO - PROCESS | 2016 | RSS: Main: 258887680 02:43:13 INFO - PROCESS | 2016 | 02:43:16 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49319/tests/kraken/driver.html?testName=json-parse-financial) 02:43:16 INFO - PROCESS | 2016 | RSS: Main: 258342912 02:43:16 INFO - PROCESS | 2016 | 02:43:18 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49319/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:43:19 INFO - PROCESS | 2016 | RSS: Main: 257507328 02:43:19 INFO - PROCESS | 2016 | 02:43:21 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:43:21 INFO - PROCESS | 2016 | RSS: Main: 257679360 02:43:21 INFO - PROCESS | 2016 | 02:43:24 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:43:24 INFO - PROCESS | 2016 | RSS: Main: 257605632 02:43:24 INFO - PROCESS | 2016 | 02:43:27 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:28 INFO - PROCESS | 2016 | RSS: Main: 257495040 02:43:28 INFO - PROCESS | 2016 | 02:43:31 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:43:32 INFO - PROCESS | 2016 | RSS: Main: 257871872 02:43:32 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | Cycle 1(1): loaded http://localhost:49319/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49319/tests/kraken/driver.html?testName=ai-astar) 02:43:34 INFO - PROCESS | 2016 | RSS: Main: 259735552 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | __start_tp_report 02:43:34 INFO - PROCESS | 2016 | _x_x_mozilla_page_load 02:43:34 INFO - PROCESS | 2016 | _x_x_mozilla_page_load_details 02:43:34 INFO - PROCESS | 2016 | |i|pagename|runs| 02:43:34 INFO - PROCESS | 2016 | |0;ai-astar;105;117;119;117;118;119;117;118;118;118 02:43:34 INFO - PROCESS | 2016 | |1;audio-beat-detection;150;115;117;150;118;141;124;119;148;128 02:43:34 INFO - PROCESS | 2016 | |2;audio-dft;200;203;200;196;196;195;197;198;199;200 02:43:34 INFO - PROCESS | 2016 | |3;audio-fft;81;61;60;86;60;59;59;60;80;60 02:43:34 INFO - PROCESS | 2016 | |4;audio-oscillator;88;70;89;73;69;69;86;69;71;88 02:43:34 INFO - PROCESS | 2016 | |5;imaging-gaussian-blur;89;92;125;87;93;86;90;89;108;88 02:43:34 INFO - PROCESS | 2016 | |6;imaging-darkroom;109;155;124;96;96;97;98;97;96;99 02:43:34 INFO - PROCESS | 2016 | |7;imaging-desaturate;90;93;86;86;91;89;93;91;89;118 02:43:34 INFO - PROCESS | 2016 | |8;json-parse-financial;56;57;56;58;60;60;64;74;76;61 02:43:34 INFO - PROCESS | 2016 | |9;json-stringify-tinderbox;68;76;72;83;78;68;70;72;72;74 02:43:34 INFO - PROCESS | 2016 | |10;stanford-crypto-aes;89;88;110;74;101;110;110;80;90;87 02:43:34 INFO - PROCESS | 2016 | |11;stanford-crypto-ccm;146;155;149;155;150;157;168;149;177;245 02:43:34 INFO - PROCESS | 2016 | |12;stanford-crypto-pbkdf2;221;202;172;174;156;234;236;216;172;171 02:43:34 INFO - PROCESS | 2016 | |13;stanford-crypto-sha256-iterative;70;73;74;59;83;91;88;93;93;64 02:43:34 INFO - PROCESS | 2016 | __end_tp_report 02:43:34 INFO - PROCESS | 2016 | __start_cc_report 02:43:34 INFO - PROCESS | 2016 | _x_x_mozilla_cycle_collect,992 02:43:34 INFO - PROCESS | 2016 | __end_cc_report 02:43:34 INFO - PROCESS | 2016 | __startTimestamp1481107414412__endTimestamp 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | ------- Summary: start ------- 02:43:34 INFO - PROCESS | 2016 | Number of tests: 14 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#0] ai-astar Cycles:10 Average:116.60 Median:118.00 stddev:4.14 (3.5%) stddev-sans-first:0.78 02:43:34 INFO - PROCESS | 2016 | Values: 105.0 117.0 119.0 117.0 118.0 119.0 117.0 118.0 118.0 118.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:134.50 stddev:14.66 (10.9%) stddev-sans-first:13.84 02:43:34 INFO - PROCESS | 2016 | Values: 150.0 115.0 117.0 150.0 118.0 141.0 124.0 119.0 148.0 128.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#2] audio-dft Cycles:10 Average:198.40 Median:199.50 stddev:2.46 (1.2%) stddev-sans-first:2.54 02:43:34 INFO - PROCESS | 2016 | Values: 200.0 203.0 200.0 196.0 196.0 195.0 197.0 198.0 199.0 200.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#3] audio-fft Cycles:10 Average:66.60 Median:60.50 stddev:10.98 (18.1%) stddev-sans-first:10.33 02:43:34 INFO - PROCESS | 2016 | Values: 81.0 61.0 60.0 86.0 60.0 59.0 59.0 60.0 80.0 60.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:79.50 stddev:9.19 (11.6%) stddev-sans-first:8.87 02:43:34 INFO - PROCESS | 2016 | Values: 88.0 70.0 89.0 73.0 69.0 69.0 86.0 69.0 71.0 88.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#5] imaging-gaussian-blur Cycles:10 Average:94.70 Median:89.00 stddev:12.35 (13.9%) stddev-sans-first:12.92 02:43:34 INFO - PROCESS | 2016 | Values: 89.0 92.0 125.0 87.0 93.0 86.0 90.0 89.0 108.0 88.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#6] imaging-darkroom Cycles:10 Average:106.70 Median:96.50 stddev:19.16 (19.9%) stddev-sans-first:20.30 02:43:34 INFO - PROCESS | 2016 | Values: 109.0 155.0 124.0 96.0 96.0 97.0 98.0 97.0 96.0 99.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:90.50 stddev:9.25 (10.2%) stddev-sans-first:9.77 02:43:34 INFO - PROCESS | 2016 | Values: 90.0 93.0 86.0 86.0 91.0 89.0 93.0 91.0 89.0 118.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:60.50 stddev:7.19 (11.9%) stddev-sans-first:7.27 02:43:34 INFO - PROCESS | 2016 | Values: 56.0 57.0 56.0 58.0 60.0 60.0 64.0 74.0 76.0 61.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:73.00 stddev:4.67 (6.4%) stddev-sans-first:4.54 02:43:34 INFO - PROCESS | 2016 | Values: 68.0 76.0 72.0 83.0 78.0 68.0 70.0 72.0 72.0 74.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:83.50 stddev:13.08 (15.7%) stddev-sans-first:13.75 02:43:34 INFO - PROCESS | 2016 | Values: 89.0 88.0 110.0 74.0 101.0 110.0 110.0 80.0 90.0 87.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#11] stanford-crypto-ccm Cycles:10 Average:165.10 Median:156.00 stddev:29.66 (19.0%) stddev-sans-first:30.64 02:43:34 INFO - PROCESS | 2016 | Values: 146.0 155.0 149.0 155.0 150.0 157.0 168.0 149.0 177.0 245.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:209.00 stddev:29.74 (14.2%) stddev-sans-first:30.07 02:43:34 INFO - PROCESS | 2016 | Values: 221.0 202.0 172.0 174.0 156.0 234.0 236.0 216.0 172.0 171.0 02:43:34 INFO - PROCESS | 2016 | 02:43:34 INFO - PROCESS | 2016 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.80 Median:85.50 stddev:12.47 (14.6%) stddev-sans-first:12.81 02:43:34 INFO - PROCESS | 2016 | Values: 70.0 73.0 74.0 59.0 83.0 91.0 88.0 93.0 93.0 64.0 02:43:34 INFO - PROCESS | 2016 | -------- Summary: end -------- 02:43:34 INFO - PROCESS | 2016 | 02:43:35 INFO - TEST-INFO | 2016: exit 0 02:43:35 INFO - TEST-OK | kraken | took 61417ms 02:43:35 INFO - SUITE-END | took 1180s 02:43:35 INFO - Completed test suite (00:19:40) 02:43:35 INFO - javascript benchmark 02:43:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7053.136227623943, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2794.4830206411802, 3249.4638384666528, 3395.4227781277195, 3400.4559270516716, 3405.4551271796486, 5588.524975377088, 5618.185363122345, 5644.6613203207835, 5731.914021289684, 5757.136429535562, 5664.461876121762, 5750.309962804469, 5763.308402991636, 5791.391903850098, 5804.100364443508, 5206.349206349207, 5219.269302297681, 5279.340082489689, 5305.867353316159, 5348.117560602496, 5226.973865130669, 5285.709285989269, 5327.840164795062, 5336.252924590561, 5389.245505629215, 5122.718250496258, 5201.427842937273, 5205.3233079699585, 5296.814611488579, 5303.8408847734245, 5230.633855630107, 5237.319148510707, 5240.397354304266, 5249.186376111671, 5254.7635356409055, 4534.662274628992, 4640.164770341337, 5155.484451554852, 5162.870928226786, 5209.400918894337, 4135.069609337905, 4332.740035597874, 5576.749046292926, 5649.096144616883, 5704.2299289595785, 6168.814935551895, 6184.536159788034, 6238.594491358047, 6245.125682404467, 6259.37406259375, 6080.0, 6194.132821405007, 6205.472534834545, 6235.282942461629, 6238.906416403757, 5777.277840269966, 5794.072948328248, 5797.4782269595935, 5802.767889284381, 5834.387389324144, 6331.873362532723, 6344.746210151542, 6363.395477429637, 6366.267879193952, 6371.808845734636, 5078.263651770472, 5562.888742225133, 6163.3528479509905, 6205.317415084427, 6219.378062193835, 5639.2668953035845, 6128.092366597219, 6171.660558669317, 6171.9691401542705, 6215.875682486416, 6169.84575385619, 6191.071339299051, 6210.844728881814, 6244.063390491372, 6258.186435763321, 6176.969115154486, 6211.844703882349, 6212.534059945522, 6263.68681565929, 6290.0, 4134.37984302357, 4748.738819364899, 4825.517448255217, 4894.339264199359, 4989.276554899592, 4380.342948557678, 4416.9178551255145, 4437.42313499243, 4444.31113177458, 4472.955270447319, 5723.370429252779, 5785.392533783976, 5847.912281315784, 5854.941450585525, 5861.3552509223955, 6090.482309003784, 6181.474574661204, 6268.122462855204, 6271.78048768291, 6281.591696539802, 5669.716514174274, 5705.7147142643535, 5706.828795136153, 5778.739956701958, 5798.188253644493, 5276.630635855453, 5374.4625537445945, 5392.218128371364, 5394.568434525228, 5413.998410294108, 6240.4071613196675, 6269.655168965751, 6304.905426418516, 6309.242890853127, 6402.231732192166, 4849.830255941025, 6136.21274067861, 6163.137160797582, 6232.065190221503, 6259.718312675849, 6330.9870420734305, 6333.20834895638, 6367.490600752021, 6384.297727250092, 6386.233651961608, 6178.9382106180165, 6179.351168127461, 6199.597026193283, 6205.844853878689, 6217.316095229611, 6063.969680151571, 6115.663638499926, 6125.540584456095, 6140.933729672948, 6236.438720515175, 5080.847574572768, 5693.28833895763, 6028.57799953999, 6050.878982420415, 6070.967935450895, 6020.6989650516425, 6058.12157237207, 6062.818115456544, 6062.909056364247, 6100.389961003864, 4903.31353610502, 4989.625778066587, 5217.530422262014, 5832.562557808096, 5894.764209431574, 6050.515958723204, 6062.454379105901, 6064.545159113172, 6071.028635418312, 6081.422264884829, 5939.990201665813, 5955.404459554184, 5964.612300200473, 5968.955432799329, 5969.403059693996], "value": 5625.522681687017, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.93548435476856, 479.2834712105403, 520.310588470277, 546.218906963043, 552.878366759313, 34713.47929781052, 39845.4023189652, 39919.201615967664, 39974.60025399745, 39976.20047599046, 40194.995125121815, 40614.18771624573, 40731.79634101833, 40820.0, 40864.0, 9176.770580735501, 9347.158755711984, 9416.058394160564, 9416.905830941705, 9442.669506567272, 7776.53340799551, 8939.821203575924, 9320.673776417827, 9423.575939082724, 9428.528573571293, 9487.28845336599, 9492.477913714743, 9496.335256532046, 9541.33210675253, 9547.474888881108, 8143.714969976022, 9086.591103400362, 9398.718038458857, 9472.289578281656, 9519.0, 7827.217278272127, 9077.909220907772, 9352.158305752515, 9398.060193980615, 9413.76465588359, 39198.60801391978, 39394.0, 39477.0, 39480.605193948264, 39654.810355689086, 3327.45097058985, 3370.3933292007428, 3523.2072783623735, 3578.8389522471552, 3833.926500579842, 25286.124097952208, 29857.10428687143, 29971.850140749375, 30372.544411833842, 30570.08289751311, 3175.6983086606733, 3206.0542140068737, 3209.326041531281, 3239.222586579204, 3280.6391296957318, 456669.0, 466296.0, 467814.6609266966, 468411.0, 469429.0, 61695.0, 62135.0, 62311.688441557504, 62366.376336236965, 62440.06339904905, 62467.0, 63235.0, 64656.676716616115, 64731.676341618935, 64939.0, 16012.839871601134, 16260.918695406684, 16262.512124636043, 16266.83733162677, 16316.75524867128, 12202.450889709808, 12457.1902826316, 12463.439145238486, 12524.74950500985, 12546.87453125457, 16558.586035349213, 17600.29598816033, 17857.910710446366, 17883.0, 17920.731189032176, 6598.3401659833635, 6610.4050635443045, 6666.733310674297, 6785.966070169717, 6802.591844489347, 848.4273115647037, 952.8570714392896, 1007.7027276953316, 1010.7119470950744, 1034.4414016431194, 26978.325541861217, 29796.40407191844, 29839.403211935638, 30238.84880575583, 30324.54513182304, 884.1026358246385, 937.5359197197295, 975.4732444480044, 1019.0930072235716, 1020.6733845169623, 10568.735781605521, 12426.378681066091, 12659.556915507914, 12705.047121465926, 12767.17013394145, 621204.0, 627631.0, 628421.0, 629569.8521507363, 630382.0, 56775.0, 56887.0, 56992.71503642455, 57095.0, 57343.0, 1352.5130952856964, 1357.83705955286, 1374.3815283122635, 1380.1650001748797, 1383.6955869708647, 24387.14644987417, 24771.88526516275, 25045.99816007339, 25112.0, 25435.491290174465, 46943.0, 47967.52032479631, 51355.2296715557, 51463.48536514737, 51476.0, 577575.0, 581208.0, 583340.0, 583925.0, 585755.0, 25311.620325695498, 26365.20904372872, 26725.732742672324, 26772.464550708486, 26786.33034174083, 43886.56113438825, 46135.0, 46702.0, 46836.06327873492, 47235.0, 31984.520232197003, 37263.813680931424, 37471.688490902685, 37513.0, 39188.23652935568, 37779.43330849984, 38089.0, 38683.03292417712, 38893.41659875161, 38963.610363896, 37319.25361492701, 37407.625923740416, 37518.24963500769, 38033.4294985581, 38365.0, 33024.66975330216, 34195.316093678484, 34986.12534686653, 35113.12217194488, 35138.0, 25657.615135772605, 25756.742432576182, 25979.83090760958, 26111.477770444104, 26220.8688956554], "value": 19359.772784632805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4239906944701, 374.24402706532805, 383.7869982159902, 385.39877790646614, 403.6347105869189, 17793.644127117466, 19047.23811047558, 19226.327078552255, 19428.41714748556, 19507.5123121922, 19892.0, 19958.800411995875, 20084.497887552818, 20085.497862553442, 20446.693299600516, 4602.539746025404, 5523.25436066131, 5745.511631511326, 5808.82573522795, 5816.534677225812, 5689.203511508392, 5814.622049566765, 5817.62185457946, 5826.242588463494, 5830.44610761979, 5472.370677372113, 5610.214569960209, 5685.744141513642, 5743.138529220609, 5775.306963164426, 5664.0, 5673.234113394701, 5703.31560212775, 5707.315122185323, 5712.600117991742, 4926.852194434173, 5020.945601423706, 5205.401378841406, 5208.0, 5265.6840589564745, 12766.680832979157, 12995.155314904501, 13026.478940842355, 19863.30478433248, 23680.526389472114, 2200.99854566172, 2257.7290725113094, 2332.4635333873302, 2797.062983900396, 2904.12876137158, 9758.560864761102, 9967.45179015154, 10013.949930250303, 10153.0, 10285.69142925706, 1534.501287081703, 1797.3170195325692, 1827.4608990347747, 1836.6234921841124, 1904.64764018657, 90113.64829527562, 116438.0, 119048.80951190378, 120169.19746203814, 122725.38637306845, 11374.601888933848, 11634.476448559835, 11713.824292635618, 11816.350100744541, 11888.167828251939, 11099.667009989713, 13059.21644701321, 13248.40382182804, 14556.981011329317, 14659.120452772868, 7135.607541585263, 8187.631556579968, 8417.789555261168, 8427.831443371098, 8451.11263317355, 8193.672253109928, 8287.295579875657, 8312.8753068704, 8460.069392366835, 8483.618237179342, 4424.137293227854, 4536.8638940831825, 4567.2920697291975, 4608.216603177468, 4636.698614590041, 1647.571631375851, 1942.9222831086881, 1960.5003620384125, 1966.7344908437465, 1984.9206031758856, 787.9763607091796, 874.0691163910415, 895.9059298773535, 925.1072714830221, 940.8635747816666, 18825.811741882408, 20209.797902021084, 20322.18711251563, 20407.489812754502, 20705.482362941046, 891.3315013739696, 937.668510714773, 949.3971328206638, 953.8903026151943, 987.7382493639192, 8671.0, 10494.73763155912, 10746.462676866126, 10759.677209683721, 10792.730181745519, 585199.0, 598999.0, 609484.0, 619981.0, 622646.7735322589, 90400.0, 121055.39472302582, 125943.74056259503, 125969.0, 126517.36741316234, 971.8104969531015, 973.0755782007263, 1011.701548043329, 1015.608990538648, 1018.180364806338, 15664.138472384127, 16209.0, 17979.0, 18017.369392071738, 18027.008514531826, 34512.65487345094, 52317.0, 52620.736896316805, 53791.0, 54168.45831541634, 71126.64436677784, 73694.89457658032, 74478.0, 75111.0, 75611.24388756041, 7744.806379840549, 7774.416918731004, 7837.177096405024, 8097.797555061171, 8172.591370431336, 10077.496125193858, 12047.0, 12084.75830483403, 12385.133040687066, 12420.0, 8889.822203555763, 10335.22485813552, 10408.167346612405, 10520.579176832842, 10842.241043126905, 9603.279754018336, 9889.208863291064, 10755.408452535186, 10797.190210734383, 10956.780864382508, 9179.0, 10714.946425267824, 10788.892111078789, 10852.782944340912, 11211.383373914186, 6629.668516574248, 7866.881996769938, 8033.879491807511, 8098.3521318293215, 8218.424710270463, 10388.220883433622, 10636.255462117888, 10646.89353106459, 10955.794862565272, 11032.393218373067], "value": 9145.59610542635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1433.634423222078, 1447.7683570628694, 1493.6788590453054, 1588.7140314743342, 1824.7810262768462, 6656.96671516643, 7118.679659415319, 7244.311790379912, 7438.739644112457, 7541.358984486312, 8017.518948863058, 8303.83392332153, 8307.252347288742, 8435.91564084359, 8443.282321002707, 1782.4028950301665, 2059.855810093294, 2131.79747923947, 2334.6498025296255, 2347.6713260143592, 1932.3430033788509, 2358.5047140100514, 2391.0555330644384, 2391.1630929174826, 2391.306521108885, 2317.0731707317123, 2335.4161459635093, 2335.5328934213226, 2344.191254017361, 2354.2466410748566, 2044.7444069491314, 2313.7223533176043, 2351.024324905171, 2352.6588644646604, 2358.599038163508, 2209.1826024370926, 2230.4869879927546, 2251.0995601759264, 2257.6952111464907, 2264.9547009059893, 8375.748727538183, 8415.495070295801, 8428.0, 8429.452085614477, 8507.957460212721, 4096.426500289962, 5183.740812959337, 5185.507376799198, 5192.584593232532, 5203.999999999962, 2967.8219306841656, 3179.9205019874457, 3318.568586083818, 3324.6010478742464, 3340.3486320167576, 1036.3263878478974, 1058.3226734889677, 1078.7934520896035, 1085.3976043295968, 1098.5166526728215, 8968.282537396992, 10595.682129536126, 10995.560177592886, 11051.834222486668, 11058.557657693682, 4537.3647689323525, 4653.744044077541, 4753.714777113384, 4771.23660214364, 4771.9522804772205, 9505.239580833517, 9559.330846840654, 9563.09150630689, 9584.233261339075, 9586.66446674363, 5217.0, 5265.631405801634, 5269.446708095671, 5273.525382715574, 5277.2875661785165, 3474.722022238215, 4291.570842915746, 4432.578905004019, 4532.116237333754, 4766.880827979328, 3372.4772660237704, 3854.383298672199, 3890.6109389061435, 3893.707971902062, 3976.1848820992204, 1098.5441041967495, 1276.814861845046, 1277.2272774971009, 1277.6231011851526, 1294.9028822838325, 760.5094713909608, 841.1714461255658, 903.7243640689521, 917.1607978699549, 934.8831396075491, 5565.749541270652, 5579.358373787067, 5709.200711900337, 5723.570732195102, 5886.735096920649, 370.9128354836611, 381.13672531715684, 429.32167175862065, 437.2195630799072, 438.53296239504823, 3256.886008989674, 3743.3823419136083, 3808.9428658570146, 3815.5802861685193, 3834.175652234783, 9773.413595184169, 10024.348417352849, 10170.389776613427, 10177.134943529734, 10218.897811021943, 9699.757506062264, 9915.702528924145, 10127.797444051224, 10129.949350253202, 10173.949130254301, 7530.171681115073, 7855.37157027425, 7859.882101768478, 7865.685372585147, 7892.684292628345, 5494.340679118372, 5500.642458240201, 5528.9447105530035, 5590.748416321357, 5655.604107712421, 9252.583633736633, 9267.582958766738, 9381.249500039843, 9433.481158536346, 9477.336586439158, 9324.627014919599, 9521.143097121292, 9536.666216682383, 9596.808063838544, 9673.854892176481, 6059.606125601822, 6594.175728033996, 6817.284185160487, 7044.330788575077, 7248.311410416002, 7829.217078292125, 8053.758387248392, 8066.435349525477, 8067.677292908453, 8069.919300806917, 7075.540089894141, 7077.858442831218, 7242.3843973262865, 7242.818929526804, 7385.9630701846145, 6914.343137401939, 7072.398846098139, 7160.7493737721015, 7161.4270858330165, 7200.819979500555, 6619.271880093283, 6774.3225677431865, 6777.2883847195335, 6787.524873258824, 6788.524803263724, 4516.977415112903, 4581.473130590025, 4656.1851675955895, 4671.906561868812, 4803.855884323476, 4812.109759694467, 4826.444958829639, 4869.415670119608, 4997.150484417585, 5059.721715305694], "value": 4271.610386375063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.54940166843886, 302.1449298485286, 311.62883313420946, 311.98908038218667, 315.64962891190777, 4897.730624815634, 5391.541718953888, 5453.890922181554, 5484.875600501892, 5556.555475561955, 4539.568740969611, 4688.484266730666, 4951.237059834525, 5332.386775520817, 5391.56867450604, 3113.972389111599, 3610.421898167338, 3838.405047217686, 4066.5933406659246, 4210.073783767566, 4090.3455447128467, 4110.020235329393, 4111.403846442264, 4257.638100761439, 4263.211305908401, 3500.457429098494, 3786.091338078855, 4119.876403707894, 4150.356694712309, 4158.584141585848, 3713.9786558696305, 4081.0613558881328, 4083.5099788025477, 4114.321137012389, 4139.405260161234, 3012.623422072241, 3049.2072061264007, 3581.982090089533, 3609.9819500902327, 3622.800745958971, 3860.4595356650093, 4913.484084171182, 4920.680155789898, 5292.708901010443, 5353.1167357386375, 3925.960740392588, 4451.799669014869, 4695.577398034194, 4703.965127671907, 4745.288206768978, 4691.859244222679, 4761.738104404257, 5729.684867332295, 5757.539396848242, 5770.932377510174, 3685.5208822852856, 3870.3033453978273, 3881.825317860703, 3882.747621404628, 3887.747296425723, 4584.166333466606, 5065.8733531662, 5679.943200568024, 5965.105234214859, 6053.969730151365, 3706.9073273167846, 3911.3155197840265, 3923.8234279456924, 3942.250972315251, 3970.82131304092, 3489.45913383426, 3793.0, 3999.200159968018, 4005.1989602079702, 4011.398290256485, 3791.7724936503346, 4105.378375541644, 4629.120467111238, 4660.790264438108, 4685.882852928704, 5237.240600112962, 5316.9202461963105, 5792.710364481759, 5803.245578074823, 5821.970890145522, 1236.5594082893329, 1262.1417436143327, 1266.5883587833991, 1268.302433661501, 1296.4749276543016, 760.6919197724931, 860.870869369587, 868.900076491199, 882.5366682491743, 882.8763973043779, 4950.950490495121, 4976.556798528386, 5045.84862454127, 5070.239464080418, 5078.619103567247, 4957.984032933264, 5265.894682106336, 5572.498475137257, 5572.58205634579, 5611.7755289788765, 4065.0, 4985.351904252424, 5018.737820416758, 5097.796088156507, 5107.948920510822, 2431.610942249232, 2798.0, 2996.3258266889775, 3002.6338016202576, 3027.0, 5715.342735585377, 5819.127130930309, 5833.154192642043, 5884.382139875252, 5903.734331954986, 5426.178387238614, 5457.426970168154, 5654.547636189095, 5742.0, 5804.593678442468, 5322.654027488278, 5875.11873219012, 5893.554175017405, 5934.347221805598, 5983.0, 4844.46710861812, 4905.23968784839, 5667.263255776723, 5709.286339207599, 5752.568557358299, 5031.74841257943, 5175.404828444626, 5627.352854421631, 5648.8763202862965, 5681.068436731531, 5057.216131499624, 5237.685738855681, 5486.369067557282, 6002.679410529677, 6038.245219347582, 3381.630439671937, 3487.9651203488656, 3723.6648701616987, 3775.5469343678933, 3790.981045094867, 5060.355384499979, 5376.73116344189, 5591.161325801162, 5605.020435490847, 5674.801381951612, 4993.550580447777, 5020.196768517019, 5565.805196818092, 5654.886902262014, 5678.403767604507, 5338.919916201183, 5512.503874651301, 5591.27313449249, 5711.143328500758, 5719.5138413235345, 4716.740579268173, 5276.868078298074, 5543.52880005204, 5566.415526369673, 5596.356419011866, 4777.617790576815, 5640.548756099584, 5653.180288858175, 5695.629784064023, 5727.341355743976, 4715.019691729413, 5520.806771762969, 5574.749136288796, 5590.608657393944, 5627.8874422512135], "value": 4049.941834534629, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.7340083662771, 684.4626967830254, 693.334398976982, 726.9600171990542, 755.7619349904779, 14068.366923488442, 14814.851851481482, 14921.477748278812, 14922.626934326647, 14947.476838310662, 13241.867581324184, 13313.866861331384, 13431.328433578306, 13584.524541641045, 13585.049046566744, 813.2314962360572, 824.9752507424787, 830.2818062376061, 832.7585000349891, 836.4061516323387, 818.3207937411963, 825.331481499984, 831.0, 831.9625616847226, 833.6248688090384, 817.7424111404888, 817.7832874288289, 843.359047124187, 861.7974775927652, 864.2437866866492, 829.8921140251789, 854.7264875239895, 860.711661593367, 861.8405594964889, 862.1421685423044, 622.6419808610067, 624.9531285153631, 632.0708558419117, 637.3339859846471, 640.3468462168562, 12420.192687475375, 12542.1847579907, 12545.560905368267, 12724.236545807282, 13815.378307976065, 12886.742265154739, 13398.0, 13464.932675336659, 13516.986226032988, 13565.389557469938, 11147.888521114848, 11231.455627651829, 11414.972652461236, 11440.0, 11615.767684646344, 3439.7420193485586, 3458.3774920514297, 3461.359648465017, 3464.4110501214855, 3473.0969947813496, 89995.0, 90129.09870901273, 90765.54617226937, 91064.0, 91111.54444227736, 10069.59721611142, 10346.689599312032, 10415.68752937413, 10438.68683939483, 10453.581856725647, 20065.799342006685, 20069.39791806248, 20088.49778755543, 20145.496362591053, 20222.898885505478, 7558.168601453835, 7586.127595326498, 7608.2391760823475, 7623.656935437919, 7650.2349765023055, 4210.368444733253, 4215.356651552706, 4224.55642157569, 4291.849785257501, 4375.496817865923, 3010.1270631517054, 3362.125847279676, 3419.6067452242814, 3485.808280544544, 3486.442169252907, 537.9912663755458, 558.3913534247608, 621.564904566805, 630.5680608782999, 665.3180489997791, 598.751518119984, 641.6599202422724, 661.6923130744227, 662.5660192573872, 663.4460225711584, 8687.391882568287, 9073.91486894459, 9221.077892210726, 9415.293852960918, 9923.0, 633.9603050996369, 645.7675236914707, 660.798456470781, 670.778643047793, 708.348319546019, 4123.278426275389, 4275.3800698898485, 4377.387165796791, 4399.64802815774, 4502.279635258343, 106158.0, 107322.9267707313, 107428.46285768677, 107729.0, 110712.33931491034, 74374.0, 78003.60998194973, 80035.79051551344, 81149.18850811417, 89749.99999999869, 55021.44978550243, 56868.43131568714, 57430.0, 60735.78528429407, 69543.0, 9390.624375024923, 9581.185599224144, 9612.567434465325, 9907.0, 9924.553395097093, 48036.279455808886, 49783.751081244365, 50798.23802643037, 51410.74294628503, 53623.65940851354, 68344.6582767083, 72067.63966180135, 73272.53454930978, 73685.6315718418, 74545.6272718633, 12266.509339626315, 12327.383630818602, 12510.789033851519, 12540.87459125397, 12680.112392132462, 14052.718945620825, 14130.646733831325, 14161.716765664423, 14335.784963225351, 14362.784558231426, 12268.631941041784, 12963.611091667264, 12971.1894894804, 13414.865851341361, 13911.234882081582, 12984.935075324564, 13090.869091308965, 13454.0, 13529.391177396845, 13809.861901380858, 12893.290869002294, 12936.223826570436, 12966.351682415652, 13200.405981730653, 13243.20540767557, 8798.824023519623, 10964.835527466936, 11237.550497980315, 11563.479643415898, 11567.537298508301, 9312.34813563044, 11359.0, 11439.828402574134, 11451.942740286246, 11531.0], "value": 7143.823272677282, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 119.0, 117.0, 118.0, 119.0, 117.0, 118.0, 118.0, 118.0], "value": 116.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 115.0, 117.0, 150.0, 118.0, 141.0, 124.0, 119.0, 148.0, 128.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 203.0, 200.0, 196.0, 196.0, 195.0, 197.0, 198.0, 199.0, 200.0], "value": 198.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 60.0, 86.0, 60.0, 59.0, 59.0, 60.0, 80.0, 60.0], "value": 66.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 89.0, 73.0, 69.0, 69.0, 86.0, 69.0, 71.0, 88.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 125.0, 87.0, 93.0, 86.0, 90.0, 89.0, 108.0, 88.0], "value": 94.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 155.0, 124.0, 96.0, 96.0, 97.0, 98.0, 97.0, 96.0, 99.0], "value": 106.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 86.0, 86.0, 91.0, 89.0, 93.0, 91.0, 89.0, 118.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 56.0, 58.0, 60.0, 60.0, 64.0, 74.0, 76.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 76.0, 72.0, 83.0, 78.0, 68.0, 70.0, 72.0, 72.0, 74.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 110.0, 74.0, 101.0, 110.0, 110.0, 80.0, 90.0, 87.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 155.0, 149.0, 155.0, 150.0, 157.0, 168.0, 149.0, 177.0, 245.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 202.0, 172.0, 174.0, 156.0, 234.0, 236.0, 216.0, 172.0, 171.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 74.0, 59.0, 83.0, 91.0, 88.0, 93.0, 93.0, 64.0], "value": 78.8, "unit": "score"}]}]} 02:43:35 INFO - Return code: 0 02:43:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:43:35 ERROR - # TBPL SUCCESS # 02:43:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:43:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:43:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:43:35 INFO - 2016-12-07 02:43:35.745 screenresolution[2021:285017] starting screenresolution argv=screenresolution get 02:43:35 INFO - 2016-12-07 02:43:35.748 screenresolution[2021:285017] Display 0: 1600x1200x32@60 02:43:35 INFO - 2016-12-07 02:43:35.754 screenresolution[2022:285020] starting screenresolution argv=screenresolution list 02:43:35 INFO - Available Modes on Display 0 02:43:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:43:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:43:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:43:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:43:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:43:35 INFO - Intel Iris: 02:43:35 INFO - Chipset Model: Intel Iris 02:43:35 INFO - Type: GPU 02:43:35 INFO - Bus: Built-In 02:43:35 INFO - VRAM (Dynamic, Max): 1536 MB 02:43:35 INFO - Vendor: Intel (0x8086) 02:43:35 INFO - Device ID: 0x0a2e 02:43:35 INFO - Revision ID: 0x0009 02:43:35 INFO - Displays: 02:43:35 INFO - Display: 02:43:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:43:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:43:35 INFO - Display Serial Number: 1600x1200 60 02:43:35 INFO - Main Display: Yes 02:43:35 INFO - Mirror: Off 02:43:35 INFO - Online: Yes 02:43:35 INFO - Rotation: Supported 02:43:35 INFO - Return code: 0 02:43:35 INFO - Running post-action listener: _resource_record_post_action 02:43:35 INFO - [mozharness: 2016-12-07 10:43:35.997520Z] Finished run-tests step (success) 02:43:35 INFO - Running post-run listener: _resource_record_post_run 02:43:36 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 8872448; Write bytes: 663005696; Read time: 85; Write time: 2009 02:43:36 INFO - TinderboxPrint: CPU usage
54.4% 02:43:36 INFO - TinderboxPrint: I/O read bytes / time
8,872,448 / 85 02:43:36 INFO - TinderboxPrint: I/O write bytes / time
663,005,696 / 2,009 02:43:36 INFO - TinderboxPrint: CPU idle
2,212.2 (45.6%) 02:43:36 INFO - TinderboxPrint: CPU system
981.4 (20.2%) 02:43:36 INFO - TinderboxPrint: CPU user
1,656.1 (34.1%) 02:43:36 INFO - TinderboxPrint: Swap in / out
366,956,544 / 0 02:43:36 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 345522688; Write bytes: 345409536; Read time: 26885; Write time: 735 02:43:36 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 8782336; Write bytes: 310325760; Read time: 83; Write time: 1242 02:43:36 INFO - Running post-run listener: _upload_blobber_files 02:43:36 INFO - Blob upload gear active. 02:43:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:43:36 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 02:43:36 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'] 02:43:36 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 02:43:36 INFO - (blobuploader) - INFO - Open directory for files ... 02:43:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:43:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:43:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:38 INFO - (blobuploader) - INFO - Done attempting. 02:43:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:43:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:43:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:39 INFO - (blobuploader) - INFO - Done attempting. 02:43:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:43:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:43:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:43:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:43:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:43:41 INFO - (blobuploader) - INFO - Done attempting. 02:43:41 INFO - (blobuploader) - INFO - Iteration through files over. 02:43:41 INFO - Return code: 0 02:43:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:43:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:43:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7f295a1c908b22daabc830f533a7450cc6e6e073b18a815052fd4d577d98fd335be08640c6a6dac5974c4edf6150c171e3ea6071522655f79d94967ff4f2eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0c3d9862a1089177ce74392d9e3de6c1c9db753c646f6de548508dc5f0180cdde4fda1fc49383a472f31fc3c578cf0a1b0f405278d4a612d9ac66631ff12d69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b4e3b71e7021decdb11d1ab359d58d58ce2af74811e7f1db99737125aa6dd58a79bf3ec9fefc77c2b206e15528681cb6ecdf337c89f2f28c7257e616f1d524"} 02:43:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:43:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:43:41 INFO - Contents: 02:43:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b7f295a1c908b22daabc830f533a7450cc6e6e073b18a815052fd4d577d98fd335be08640c6a6dac5974c4edf6150c171e3ea6071522655f79d94967ff4f2eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0c3d9862a1089177ce74392d9e3de6c1c9db753c646f6de548508dc5f0180cdde4fda1fc49383a472f31fc3c578cf0a1b0f405278d4a612d9ac66631ff12d69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b4e3b71e7021decdb11d1ab359d58d58ce2af74811e7f1db99737125aa6dd58a79bf3ec9fefc77c2b206e15528681cb6ecdf337c89f2f28c7257e616f1d524"} 02:43:41 INFO - Running post-run listener: copy_logs_to_upload_dir 02:43:41 INFO - Copying logs to upload dir... 02:43:41 INFO - mkdir: /builds/slave/test/build/upload/logs 02:43:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.344823 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-12-07 02:43:41.645952) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 02:43:41.649319) ========= 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.BJgXfW7fQJ/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.p303yaThw8/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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/b7f295a1c908b22daabc830f533a7450cc6e6e073b18a815052fd4d577d98fd335be08640c6a6dac5974c4edf6150c171e3ea6071522655f79d94967ff4f2eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0c3d9862a1089177ce74392d9e3de6c1c9db753c646f6de548508dc5f0180cdde4fda1fc49383a472f31fc3c578cf0a1b0f405278d4a612d9ac66631ff12d69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b4e3b71e7021decdb11d1ab359d58d58ce2af74811e7f1db99737125aa6dd58a79bf3ec9fefc77c2b206e15528681cb6ecdf337c89f2f28c7257e616f1d524"} build_url:https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/dBpgzGowS6mim54Fl0OjkQ/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/b7f295a1c908b22daabc830f533a7450cc6e6e073b18a815052fd4d577d98fd335be08640c6a6dac5974c4edf6150c171e3ea6071522655f79d94967ff4f2eaf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d0c3d9862a1089177ce74392d9e3de6c1c9db753c646f6de548508dc5f0180cdde4fda1fc49383a472f31fc3c578cf0a1b0f405278d4a612d9ac66631ff12d69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/48b4e3b71e7021decdb11d1ab359d58d58ce2af74811e7f1db99737125aa6dd58a79bf3ec9fefc77c2b206e15528681cb6ecdf337c89f2f28c7257e616f1d524"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 02:43:41.683930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:43:41.684283) ========= 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.BJgXfW7fQJ/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.p303yaThw8/Listeners TMPDIR=/var/folders/bz/5pkfnsh516b43lwcn2l8vvq400000w/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.005140 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 02:43:41.733200) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 02:43:41.733527) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 02:43:41.733911) ========= ========= Total master_lag: 0.20 =========