builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0362 starttime: 1483615354.86 results: success (0) buildid: 20170105014139 builduid: 3429f4099bff40aaa7aac16648c57e9f revision: 7f79cc643a90823824cf1b75f9487a43eadd0855 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:34.864681) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:34.865143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:34.865418) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:34.893198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:34.893627) ========= 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.7DXaHj0p52/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.EMVX5wfgzN/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-05 03:22:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2017-01-05 03:22:35 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134265 ========= master_lag: 0.42 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:35.450728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:35.451036) ========= 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.7DXaHj0p52/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.EMVX5wfgzN/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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.021695 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:35.498413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-05 03:22:35.498768) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7f79cc643a90823824cf1b75f9487a43eadd0855 --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 7f79cc643a90823824cf1b75f9487a43eadd0855 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7DXaHj0p52/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.EMVX5wfgzN/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-05 03:22:35,577 truncating revision to first 12 chars 2017-01-05 03:22:35,577 Setting DEBUG logging. 2017-01-05 03:22:35,577 attempt 1/10 2017-01-05 03:22:35,577 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7f79cc643a90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-05 03:22:37,433 unpacking tar archive at: mozilla-aurora-7f79cc643a90/testing/mozharness/ program finished with exit code 0 elapsedTime=2.125547 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-05 03:22:37.648114) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:37.648429) ========= script_repo_revision: 7f79cc643a90823824cf1b75f9487a43eadd0855 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:37.651681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:37.651965) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-05 03:22:37.671338) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-05 03:22:37.671655) ========= /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.7DXaHj0p52/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.EMVX5wfgzN/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:22:37 INFO - MultiFileLogger online at 20170105 03:22:37 in /builds/slave/test 03:22:37 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 03:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:37 INFO - {'append_to_log': False, 03:22:37 INFO - 'base_work_dir': '/builds/slave/test', 03:22:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:37 INFO - 'branch': 'Mozilla-Aurora', 03:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:37 INFO - 'config_files': ('talos/mac_config.py',), 03:22:37 INFO - 'default_actions': ('clobber', 03:22:37 INFO - 'read-buildbot-config', 03:22:37 INFO - 'download-and-extract', 03:22:37 INFO - 'populate-webroot', 03:22:37 INFO - 'create-virtualenv', 03:22:37 INFO - 'install', 03:22:37 INFO - 'run-tests'), 03:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:37 INFO - 'download_minidump_stackwalk': True, 03:22:37 INFO - 'download_symbols': 'ondemand', 03:22:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:37 INFO - 'installer_path': 'installer.exe', 03:22:37 INFO - 'log_level': 'info', 03:22:37 INFO - 'log_name': 'talos', 03:22:37 INFO - 'log_to_console': True, 03:22:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:22:37 INFO - 'opt_config_files': (), 03:22:37 INFO - 'pip_index': False, 03:22:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:37 INFO - 'cmd': ('bash', 03:22:37 INFO - '-c', 03:22:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:37 INFO - 'enabled': True, 03:22:37 INFO - 'halt_on_failure': False, 03:22:37 INFO - 'name': 'check_screen_resolution'},), 03:22:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:22:37 INFO - 'cmd': ('bash', 03:22:37 INFO - '-c', 03:22:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:22:37 INFO - 'enabled': True, 03:22:37 INFO - 'halt_on_failure': False, 03:22:37 INFO - 'name': 'check_screen_resolution'},), 03:22:37 INFO - 'run_cmd_checks_enabled': True, 03:22:37 INFO - 'sps_profile': False, 03:22:37 INFO - 'sps_profile_interval': 0, 03:22:37 INFO - 'suite': 'dromaeojs-e10s', 03:22:37 INFO - 'system_bits': '32', 03:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:37 INFO - 'title': 't-yosemite-r7-0362', 03:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:37 INFO - 'use_talos_json': True, 03:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:37 INFO - 'work_dir': 'build'} 03:22:37 INFO - [mozharness: 2017-01-05 11:22:37.873212Z] Running clobber step. 03:22:37 INFO - Running pre-action listener: _resource_record_pre_action 03:22:37 INFO - Running main action method: clobber 03:22:37 INFO - rmtree: /builds/slave/test/build 03:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:39 INFO - Running post-action listener: _resource_record_post_action 03:22:39 INFO - [mozharness: 2017-01-05 11:22:39.406444Z] Finished clobber step (success) 03:22:39 INFO - [mozharness: 2017-01-05 11:22:39.406661Z] Running read-buildbot-config step. 03:22:39 INFO - Running pre-action listener: _resource_record_pre_action 03:22:39 INFO - Running main action method: read_buildbot_config 03:22:39 INFO - Using buildbot properties: 03:22:39 INFO - { 03:22:39 INFO - "project": "", 03:22:39 INFO - "product": "firefox", 03:22:39 INFO - "script_repo_revision": "production", 03:22:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:22:39 INFO - "repository": "", 03:22:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:22:39 INFO - "buildid": "20170105014139", 03:22:39 INFO - "stage_platform": "macosx64", 03:22:39 INFO - "basedir": "/builds/slave/test", 03:22:39 INFO - "nightly_build": "True", 03:22:39 INFO - "buildnumber": 63, 03:22:39 INFO - "slavename": "t-yosemite-r7-0362", 03:22:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:22:39 INFO - "platform": "yosemite_r7", 03:22:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:22:39 INFO - "branch": "mozilla-aurora", 03:22:39 INFO - "repo_path": "releases/mozilla-aurora", 03:22:39 INFO - "revision": "7f79cc643a90823824cf1b75f9487a43eadd0855", 03:22:39 INFO - "pgo_build": "False", 03:22:39 INFO - "builduid": "3429f4099bff40aaa7aac16648c57e9f", 03:22:39 INFO - "slavebuilddir": "test" 03:22:39 INFO - } 03:22:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 03:22:39 INFO - Running post-action listener: _resource_record_post_action 03:22:39 INFO - [mozharness: 2017-01-05 11:22:39.410611Z] Finished read-buildbot-config step (success) 03:22:39 INFO - [mozharness: 2017-01-05 11:22:39.410761Z] Running download-and-extract step. 03:22:39 INFO - Running pre-action listener: _resource_record_pre_action 03:22:39 INFO - Running main action method: download_and_extract 03:22:39 INFO - mkdir: /builds/slave/test/build/tests 03:22:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:22:39 INFO - trying https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 03:22:39 INFO - Downloading https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/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 03:22:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/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 03:22:40 INFO - Downloaded 1199 bytes. 03:22:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 03:22:40 INFO - Using the following test package requirements: 03:22:40 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:22:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 03:22:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 03:22:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'jsshell-mac.zip'], 03:22:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 03:22:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 03:22:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 03:22:40 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 03:22:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 03:22:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 03:22:40 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 03:22:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:22:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:22:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:22:40 INFO - Fetch https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:22:41 INFO - Http code: 200 03:22:41 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 03:22:41 INFO - x-amz-cf-id: lb7WGRghkoIlg9gPWTiId1j5SIfcXQ7gVaxT7krkTnWWL8c_ZFA_Ew== 03:22:41 INFO - x-amz-version-id: I4Wzi72Y_trDJbHSC3qmaGM6HSHpyRKC 03:22:41 INFO - Expected file size: 16269442 03:22:41 INFO - Obtained file size: 16269442 03:22:48 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 03:22:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 03:22:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:22:48 INFO - Fetch https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 03:22:49 INFO - Http code: 200 03:22:49 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 03:22:49 INFO - x-amz-cf-id: MeLW1QR45a-SsE4CPfwzaU0TmHRsHHAqcEhDkHq-Tkn3fTUnP0LzCw== 03:22:49 INFO - x-amz-version-id: I4Wzi72Y_trDJbHSC3qmaGM6HSHpyRKC 03:22:49 INFO - Expected file size: 16269442 03:22:49 INFO - Obtained file size: 16269442 03:22:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 03:22:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:22:55 INFO - Fetch https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 03:22:56 INFO - Http code: 200 03:22:56 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 03:22:56 INFO - x-amz-cf-id: AF7zYmMengB9sIfnMdwJy57vSbDqv0Q57a5nk-fZogI0e8JjhMaqgw== 03:22:56 INFO - x-amz-version-id: oMpPKUSOXBKsPcPn1LRmJ12TwCQcz8Wy 03:22:57 INFO - Expected file size: 14409038 03:22:57 INFO - Obtained file size: 14409038 03:22:57 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')]} 03:22:57 INFO - trying https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:22:57 INFO - Downloading https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 03:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/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 03:23:00 INFO - Downloaded 109826326 bytes. 03:23:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:23:00 INFO - mkdir: /builds/slave/test/properties 03:23:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:23:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:23:00 INFO - Contents: 03:23:00 INFO - build_url:https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 03:23:01 INFO - Running post-action listener: _resource_record_post_action 03:23:01 INFO - Running post-action listener: set_extra_try_arguments 03:23:01 INFO - [mozharness: 2017-01-05 11:23:01.323896Z] Finished download-and-extract step (success) 03:23:01 INFO - [mozharness: 2017-01-05 11:23:01.324033Z] Running populate-webroot step. 03:23:01 INFO - Running pre-action listener: _resource_record_pre_action 03:23:01 INFO - Running main action method: populate_webroot 03:23:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:23:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:23:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:23:01 INFO - '--tppagecycles', 03:23:01 INFO - '7'], 03:23:01 INFO - 'tests': ['tsvgm']}}, 03:23:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:23:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:23:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:23:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:23:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:23:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['damp', 'tps']}, 03:23:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'tests': ['damp', 'tps']}, 03:23:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['dromaeo_dom']}, 03:23:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:23:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['basic_compositor_video']}, 03:23:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:23:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['a11yr', 03:23:01 INFO - 'ts_paint', 03:23:01 INFO - 'tpaint', 03:23:01 INFO - 'sessionrestore', 03:23:01 INFO - 'sessionrestore_no_auto_restore', 03:23:01 INFO - 'tabpaint']}, 03:23:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:23:01 INFO - 'ts_paint', 03:23:01 INFO - 'tpaint', 03:23:01 INFO - 'sessionrestore', 03:23:01 INFO - 'sessionrestore_no_auto_restore', 03:23:01 INFO - 'tabpaint']}, 03:23:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:23:01 INFO - 'ts_paint', 03:23:01 INFO - 'tpaint', 03:23:01 INFO - 'sessionrestore', 03:23:01 INFO - 'sessionrestore_no_auto_restore', 03:23:01 INFO - 'tabpaint']}, 03:23:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:23:01 INFO - 'ts_paint', 03:23:01 INFO - 'tpaint', 03:23:01 INFO - 'sessionrestore', 03:23:01 INFO - 'sessionrestore_no_auto_restore', 03:23:01 INFO - 'tabpaint']}, 03:23:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['a11yr', 03:23:01 INFO - 'ts_paint', 03:23:01 INFO - 'tpaint', 03:23:01 INFO - 'sessionrestore', 03:23:01 INFO - 'sessionrestore_no_auto_restore', 03:23:01 INFO - 'tabpaint']}, 03:23:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['a11yr', 03:23:01 INFO - 'ts_paint', 03:23:01 INFO - 'tpaint', 03:23:01 INFO - 'sessionrestore', 03:23:01 INFO - 'sessionrestore_no_auto_restore', 03:23:01 INFO - 'tabpaint']}, 03:23:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['tsvgx', 03:23:01 INFO - 'tsvgr_opacity', 03:23:01 INFO - 'tart', 03:23:01 INFO - 'tscrollx', 03:23:01 INFO - 'cart']}, 03:23:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:23:01 INFO - 'tsvgr_opacity', 03:23:01 INFO - 'tart', 03:23:01 INFO - 'tscrollx', 03:23:01 INFO - 'cart']}, 03:23:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'talos_options': ['--disable-e10s'], 03:23:01 INFO - 'tests': ['tp5o']}, 03:23:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'tests': ['tp5o']}, 03:23:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'talos_options': ['--disable-e10s', 03:23:01 INFO - '--xperf_path', 03:23:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:01 INFO - 'tests': ['tp5n']}, 03:23:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:23:01 INFO - 'talos_options': ['--xperf_path', 03:23:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:23:01 INFO - 'tests': ['tp5n']}}, 03:23:01 INFO - 'talos.zip': {'path': '', 03:23:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:23:01 INFO - Running post-action listener: _resource_record_post_action 03:23:01 INFO - [mozharness: 2017-01-05 11:23:01.342781Z] Finished populate-webroot step (success) 03:23:01 INFO - [mozharness: 2017-01-05 11:23:01.342913Z] Running create-virtualenv step. 03:23:01 INFO - Running pre-action listener: _resource_record_pre_action 03:23:01 INFO - Running main action method: create_virtualenv 03:23:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:23:01 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 03:23:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:23:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:23:01 INFO - Using real prefix '/tools/python27' 03:23:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:02 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:05 INFO - Installing pip.................done. 03:23:05 INFO - Return code: 0 03:23:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:23:05 INFO - Reading from file tmpfile_stdout 03:23:05 INFO - Output received: 03:23:05 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) 03:23:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:05 INFO - 'HOME': '/Users/cltbld', 03:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PAGER': '/bin/cat', 03:23:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:05 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - 'XPC_FLAGS': '0x0', 03:23:05 INFO - 'XPC_SERVICE_NAME': '0', 03:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 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 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:23:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:23:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:05 INFO - 'HOME': '/Users/cltbld', 03:23:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PAGER': '/bin/cat', 03:23:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:05 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - 'XPC_FLAGS': '0x0', 03:23:05 INFO - 'XPC_SERVICE_NAME': '0', 03:23:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking psutil>=3.1.1 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:09 INFO - Installing collected packages: psutil 03:23:09 INFO - Running setup.py install for psutil 03:23:09 INFO - building 'psutil._psutil_osx' extension 03:23:09 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 03:23:09 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 03:23:09 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 03:23:09 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 03:23:09 INFO - building 'psutil._psutil_posix' extension 03:23:09 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 03:23:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:23:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:23:10 INFO - ^ 03:23:10 INFO - 1 warning generated. 03:23:10 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 03:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:10 INFO - Successfully installed psutil 03:23:10 INFO - Cleaning up... 03:23:10 INFO - Return code: 0 03:23:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23:10 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')]} 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:10 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')]} 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:10 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:10 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 03:23:10 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 03:23:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:10 INFO - 'HOME': '/Users/cltbld', 03:23:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:10 INFO - 'LOGNAME': 'cltbld', 03:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:10 INFO - 'MOZ_NO_REMOTE': '1', 03:23:10 INFO - 'NO_EM_RESTART': '1', 03:23:10 INFO - 'PAGER': '/bin/cat', 03:23:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:10 INFO - 'PWD': '/builds/slave/test', 03:23:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:10 INFO - 'SHELL': '/bin/bash', 03:23:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:10 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:10 INFO - 'USER': 'cltbld', 03:23:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:10 INFO - 'XPC_FLAGS': '0x0', 03:23:10 INFO - 'XPC_SERVICE_NAME': '0', 03:23:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 03: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 03: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 03: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 03: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 03: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 03: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 03:23:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:13 INFO - Installing collected packages: mozsystemmonitor 03:23:13 INFO - Running setup.py install for mozsystemmonitor 03:23:13 INFO - Successfully installed mozsystemmonitor 03:23:13 INFO - Cleaning up... 03:23:13 INFO - Return code: 0 03:23:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:13 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')]} 03:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:13 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')]} 03:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:13 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:13 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 03:23:13 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 03:23:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:13 INFO - 'HOME': '/Users/cltbld', 03:23:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:13 INFO - 'LOGNAME': 'cltbld', 03:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:13 INFO - 'MOZ_NO_REMOTE': '1', 03:23:13 INFO - 'NO_EM_RESTART': '1', 03:23:13 INFO - 'PAGER': '/bin/cat', 03:23:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:13 INFO - 'PWD': '/builds/slave/test', 03:23:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:13 INFO - 'SHELL': '/bin/bash', 03:23:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:13 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:13 INFO - 'USER': 'cltbld', 03:23:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:13 INFO - 'XPC_FLAGS': '0x0', 03:23:13 INFO - 'XPC_SERVICE_NAME': '0', 03:23:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:13 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 03:23:13 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 03:23:13 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 03:23:13 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 03:23:13 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 03:23:13 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 03:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 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 03:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:16 INFO - warning: no files found matching '*.txt' 03:23:16 INFO - no previously-included directories found matching 'build' 03:23:16 INFO - no previously-included directories found matching 'dist' 03:23:16 INFO - no previously-included directories found matching '.git*' 03:23:16 INFO - Installing collected packages: jsonschema, functools32 03:23:16 INFO - Running setup.py install for functools32 03:23:16 INFO - warning: no files found matching '*.txt' 03:23:17 INFO - no previously-included directories found matching 'build' 03:23:17 INFO - no previously-included directories found matching 'dist' 03:23:17 INFO - no previously-included directories found matching '.git*' 03:23:17 INFO - Successfully installed jsonschema functools32 03:23:17 INFO - Cleaning up... 03:23:17 INFO - Return code: 0 03:23:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:17 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:17 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 03:23:17 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 03:23:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:17 INFO - 'HOME': '/Users/cltbld', 03:23:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:17 INFO - 'LOGNAME': 'cltbld', 03:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:17 INFO - 'MOZ_NO_REMOTE': '1', 03:23:17 INFO - 'NO_EM_RESTART': '1', 03:23:17 INFO - 'PAGER': '/bin/cat', 03:23:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:17 INFO - 'PWD': '/builds/slave/test', 03:23:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:17 INFO - 'SHELL': '/bin/bash', 03:23:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:17 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:17 INFO - 'USER': 'cltbld', 03:23:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:17 INFO - 'XPC_FLAGS': '0x0', 03:23:17 INFO - 'XPC_SERVICE_NAME': '0', 03:23:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:17 INFO - Cleaning up... 03:23:17 INFO - Return code: 0 03:23:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03: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')]} 03:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:17 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:17 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 03:23:17 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 03:23:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:17 INFO - 'HOME': '/Users/cltbld', 03:23:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:17 INFO - 'LOGNAME': 'cltbld', 03:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:17 INFO - 'MOZ_NO_REMOTE': '1', 03:23:17 INFO - 'NO_EM_RESTART': '1', 03:23:17 INFO - 'PAGER': '/bin/cat', 03:23:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:17 INFO - 'PWD': '/builds/slave/test', 03:23:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:17 INFO - 'SHELL': '/bin/bash', 03:23:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:17 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:17 INFO - 'USER': 'cltbld', 03:23:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:17 INFO - 'XPC_FLAGS': '0x0', 03:23:17 INFO - 'XPC_SERVICE_NAME': '0', 03:23:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:20 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:20 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 03:23:20 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 03:23:20 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 03:23:20 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 03:23:20 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 03:23:20 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 03:23:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 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 03:23:21 INFO - Downloading docopt-0.6.1.tar.gz 03:23:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:21 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:21 INFO - Running setup.py install for blobuploader 03:23:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:21 INFO - Running setup.py install for requests 03:23:22 INFO - Running setup.py install for docopt 03:23:22 INFO - Successfully installed blobuploader requests docopt 03:23:22 INFO - Cleaning up... 03:23:22 INFO - Return code: 0 03:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03: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')]} 03:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03: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')]} 03:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:22 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:22 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 03:23:22 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 03:23:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:22 INFO - 'HOME': '/Users/cltbld', 03:23:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:22 INFO - 'LOGNAME': 'cltbld', 03:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:22 INFO - 'MOZ_NO_REMOTE': '1', 03:23:22 INFO - 'NO_EM_RESTART': '1', 03:23:22 INFO - 'PAGER': '/bin/cat', 03:23:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:22 INFO - 'PWD': '/builds/slave/test', 03:23:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:22 INFO - 'SHELL': '/bin/bash', 03:23:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:22 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:22 INFO - 'USER': 'cltbld', 03:23:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:22 INFO - 'XPC_FLAGS': '0x0', 03:23:22 INFO - 'XPC_SERVICE_NAME': '0', 03:23:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:22 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-UAAMAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:22 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-7GN86P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:22 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-FVVOI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-nDv5aV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-muGljj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-rFvwR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-x13AIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-azehlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-07aVbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-9mIFlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-fRKf5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-lszL8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:23 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-Dy6b_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:24 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-YzVYnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:24 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-o720mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:24 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-IYlDiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:24 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-oCEyDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:24 INFO - Running setup.py install for manifestparser 03:23:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:24 INFO - Running setup.py install for mozcrash 03:23:24 INFO - Running setup.py install for mozdebug 03:23:24 INFO - Running setup.py install for mozdevice 03:23:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Running setup.py install for mozfile 03:23:25 INFO - Running setup.py install for mozhttpd 03:23:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Running setup.py install for mozinfo 03:23:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Running setup.py install for mozInstall 03:23:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:25 INFO - Running setup.py install for mozleak 03:23:25 INFO - Running setup.py install for mozlog 03:23:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:26 INFO - Running setup.py install for moznetwork 03:23:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:26 INFO - Running setup.py install for mozprocess 03:23:26 INFO - Running setup.py install for mozprofile 03:23:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:26 INFO - Running setup.py install for mozrunner 03:23:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:26 INFO - Running setup.py install for mozscreenshot 03:23:26 INFO - Running setup.py install for moztest 03:23:27 INFO - Running setup.py install for mozversion 03:23:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:27 INFO - Cleaning up... 03:23:27 INFO - Return code: 0 03:23:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:27 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')]} 03:23:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:27 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')]} 03:23:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:27 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:27 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 03:23:27 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 03:23:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:27 INFO - 'HOME': '/Users/cltbld', 03:23:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:27 INFO - 'LOGNAME': 'cltbld', 03:23:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:27 INFO - 'MOZ_NO_REMOTE': '1', 03:23:27 INFO - 'NO_EM_RESTART': '1', 03:23:27 INFO - 'PAGER': '/bin/cat', 03:23:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:27 INFO - 'PWD': '/builds/slave/test', 03:23:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:27 INFO - 'SHELL': '/bin/bash', 03:23:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:27 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:27 INFO - 'USER': 'cltbld', 03:23:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:27 INFO - 'XPC_FLAGS': '0x0', 03:23:27 INFO - 'XPC_SERVICE_NAME': '0', 03:23:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:27 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-7bs_ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:27 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)) 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:27 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-mUEI5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:27 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)) 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:27 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-H2fUlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:27 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)) 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:27 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-lvyOE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:27 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)) 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:27 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-TOX09S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:27 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)) 03:23:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:27 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-SPfJFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-4VVuiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-2IMbQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-4yzB4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-B2ljJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-67qEPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-pc67YL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-9R5JsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-SFiSPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:28 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)) 03:23:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:28 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-F19GQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:29 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)) 03:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:29 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-RJWEY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:23:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:29 INFO - Running setup.py (path:/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/pip-tSRG5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:29 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)) 03:23:29 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)) 03:23:29 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)) 03:23:29 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)) 03:23:29 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)) 03:23:29 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)) 03:23:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:32 INFO - Downloading blessings-1.6.tar.gz 03:23:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:32 INFO - Installing collected packages: blessings 03:23:32 INFO - Running setup.py install for blessings 03:23:32 INFO - Successfully installed blessings 03:23:32 INFO - Cleaning up... 03:23:32 INFO - Return code: 0 03:23:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:32 INFO - Reading from file tmpfile_stdout 03:23:32 INFO - Current package versions: 03:23:32 INFO - blessings == 1.6 03:23:32 INFO - blobuploader == 1.2.4 03:23:32 INFO - docopt == 0.6.1 03:23:32 INFO - functools32 == 3.2.3-2 03:23:32 INFO - jsonschema == 2.5.1 03:23:32 INFO - manifestparser == 1.1 03:23:32 INFO - mozInstall == 1.12 03:23:32 INFO - mozcrash == 1.0 03:23:32 INFO - mozdebug == 0.1 03:23:32 INFO - mozdevice == 0.48 03:23:32 INFO - mozfile == 1.2 03:23:32 INFO - mozhttpd == 0.7 03:23:32 INFO - mozinfo == 0.9 03:23:32 INFO - mozleak == 0.1 03:23:32 INFO - mozlog == 3.4 03:23:32 INFO - moznetwork == 0.27 03:23:32 INFO - mozprocess == 0.23 03:23:32 INFO - mozprofile == 0.28 03:23:32 INFO - mozrunner == 6.13 03:23:32 INFO - mozscreenshot == 0.1 03:23:32 INFO - mozsystemmonitor == 0.3 03:23:32 INFO - moztest == 0.8 03:23:32 INFO - mozversion == 1.4 03:23:32 INFO - psutil == 3.1.1 03:23:32 INFO - requests == 1.2.3 03:23:32 INFO - wsgiref == 0.1.2 03:23:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 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 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:33 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 03:23:33 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 03:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:33 INFO - 'HOME': '/Users/cltbld', 03:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:33 INFO - 'LOGNAME': 'cltbld', 03:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:33 INFO - 'MOZ_NO_REMOTE': '1', 03:23:33 INFO - 'NO_EM_RESTART': '1', 03:23:33 INFO - 'PAGER': '/bin/cat', 03:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:33 INFO - 'PWD': '/builds/slave/test', 03:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:33 INFO - 'SHELL': '/bin/bash', 03:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:33 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:33 INFO - 'USER': 'cltbld', 03:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:33 INFO - 'XPC_FLAGS': '0x0', 03:23:33 INFO - 'XPC_SERVICE_NAME': '0', 03:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 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)) 03:23:33 INFO - Cleaning up... 03:23:33 INFO - Return code: 0 03:23:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1038d6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10384c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd68454430>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, '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.7DXaHj0p52/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.EMVX5wfgzN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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 03:23:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:23:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:23:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:23:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:23:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:23:33 INFO - 'HOME': '/Users/cltbld', 03:23:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:23:33 INFO - 'LOGNAME': 'cltbld', 03:23:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:33 INFO - 'MOZ_NO_REMOTE': '1', 03:23:33 INFO - 'NO_EM_RESTART': '1', 03:23:33 INFO - 'PAGER': '/bin/cat', 03:23:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:23:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:33 INFO - 'PWD': '/builds/slave/test', 03:23:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:23:33 INFO - 'SHELL': '/bin/bash', 03:23:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:23:33 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:23:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:23:33 INFO - 'USER': 'cltbld', 03:23:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:23:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:23:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:33 INFO - 'XPC_FLAGS': '0x0', 03:23:33 INFO - 'XPC_SERVICE_NAME': '0', 03:23:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:23:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:33 INFO - Cleaning up... 03:23:33 INFO - Return code: 0 03:23:33 INFO - Running post-action listener: _resource_record_post_action 03:23:33 INFO - Running post-action listener: _start_resource_monitoring 03:23:34 INFO - Starting resource monitoring. 03:23:34 INFO - [mozharness: 2017-01-05 11:23:34.023689Z] Finished create-virtualenv step (success) 03:23:34 INFO - [mozharness: 2017-01-05 11:23:34.024828Z] Running install step. 03:23:34 INFO - Running pre-action listener: _resource_record_pre_action 03:23:34 INFO - Running main action method: install 03:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:34 INFO - Reading from file tmpfile_stdout 03:23:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:34 INFO - Reading from file tmpfile_stdout 03:23:34 INFO - Output received: 03:23:34 INFO - Usage: mozinstall [options] installer 03:23:34 INFO - Options: 03:23:34 INFO - -h, --help show this help message and exit 03:23:34 INFO - -d DEST, --destination=DEST 03:23:34 INFO - Directory to install application into. [default: 03:23:34 INFO - "/builds/slave/test"] 03:23:34 INFO - --app=APP Application being installed. [default: firefox] 03:23:34 INFO - mkdir: /builds/slave/test/build/application 03:23:34 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'] 03:23:34 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 03:24:05 INFO - Reading from file tmpfile_stdout 03:24:05 INFO - Output received: 03:24:05 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:24:05 INFO - Running post-action listener: _resource_record_post_action 03:24:05 INFO - [mozharness: 2017-01-05 11:24:05.846144Z] Finished install step (success) 03:24:05 INFO - [mozharness: 2017-01-05 11:24:05.846302Z] Running run-tests step. 03:24:05 INFO - Running pre-action listener: _resource_record_pre_action 03:24:05 INFO - Running main action method: run_tests 03:24:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:24:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:24:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:24:05 INFO - 2017-01-05 03:24:05.860 screenresolution[2207:28641] starting screenresolution argv=screenresolution get 03:24:05 INFO - 2017-01-05 03:24:05.863 screenresolution[2207:28641] Display 0: 1600x1200x32@60 03:24:05 INFO - 2017-01-05 03:24:05.870 screenresolution[2208:28643] starting screenresolution argv=screenresolution list 03:24:05 INFO - Available Modes on Display 0 03:24:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:24:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:24:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:24:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:24:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:24:06 INFO - Intel Iris: 03:24:06 INFO - Chipset Model: Intel Iris 03:24:06 INFO - Type: GPU 03:24:06 INFO - Bus: Built-In 03:24:06 INFO - VRAM (Dynamic, Max): 1536 MB 03:24:06 INFO - Vendor: Intel (0x8086) 03:24:06 INFO - Device ID: 0x0a2e 03:24:06 INFO - Revision ID: 0x0009 03:24:06 INFO - Displays: 03:24:06 INFO - Display: 03:24:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:24:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:24:06 INFO - Display Serial Number: 1600x1200 60 03:24:06 INFO - Main Display: Yes 03:24:06 INFO - Mirror: Off 03:24:06 INFO - Online: Yes 03:24:06 INFO - Rotation: Supported 03:24:06 INFO - Return code: 0 03:24:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:24:06 INFO - Python 2.7.3 03:24:06 INFO - Return code: 0 03:24:06 INFO - grabbing minidump binary from tooltool 03:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:06 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1036ead30>, '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 0x103550db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1036e2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:24:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:24:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:24:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:24:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:24:06 INFO - Return code: 0 03:24:06 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:24:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:24:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:24:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:24:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:24:06 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/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0362', '--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 03:24:06 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/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0362 --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 03:24:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7DXaHj0p52/Render', 03:24:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:24:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:24:06 INFO - 'HOME': '/Users/cltbld', 03:24:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:24:06 INFO - 'LOGNAME': 'cltbld', 03:24:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:24:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:24:06 INFO - 'MOZ_NO_REMOTE': '1', 03:24:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:24:06 INFO - 'NO_EM_RESTART': '1', 03:24:06 INFO - 'PAGER': '/bin/cat', 03:24:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:24:06 INFO - 'PWD': '/builds/slave/test', 03:24:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:24:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:24:06 INFO - 'SHELL': '/bin/bash', 03:24:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EMVX5wfgzN/Listeners', 03:24:06 INFO - 'TMPDIR': '/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/', 03:24:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:24:06 INFO - 'USER': 'cltbld', 03:24:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:24:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:24:06 INFO - 'XPC_FLAGS': '0x0', 03:24:06 INFO - 'XPC_SERVICE_NAME': '0', 03:24:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:24:06 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/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0362', '--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 03:24:06 INFO - mozversion application_buildid: 20170105014139 03:24:06 INFO - mozversion application_changeset: 7f79cc643a90823824cf1b75f9487a43eadd0855 03:24:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:24:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:24:06 INFO - mozversion application_name: Firefox 03:24:06 INFO - mozversion application_remotingname: firefox-dev 03:24:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:06 INFO - mozversion application_vendor: Mozilla 03:24:06 INFO - mozversion application_version: 52.0a2 03:24:06 INFO - mozversion platform_buildid: 20170105014139 03:24:06 INFO - mozversion platform_changeset: 7f79cc643a90823824cf1b75f9487a43eadd0855 03:24:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:24:06 INFO - mozversion platform_version: 52.0a2 03:24:06 INFO - using testdate: 1483615446 03:24:06 INFO - actual date: 1483615446 03:24:06 INFO - starting webserver on 'localhost:59943' 03:24:06 INFO - SUITE-START | Running 2 tests 03:24:06 INFO - TEST-START | dromaeo_css 03:24:06 INFO - operating with platform_type : mac_ 03:24:06 INFO - Initialising browser for dromaeo_css test... 03:24:06 INFO - TEST-INFO | started process 2218 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpi5uLoY/profile http://localhost:59943/getInfo.html) 03:24:09 INFO - PROCESS | 2218 | 2017-01-05 03:24:09.720 plugin-container[2220:28823] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d4b, name = 'com.apple.tsm.portname' 03:24:09 INFO - PROCESS | 2218 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:24:09 INFO - PROCESS | 2218 | 2017-01-05 03:24:09.723 plugin-container[2220:28823] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920b, name = 'com.apple.CFPasteboardClient' 03:24:09 INFO - PROCESS | 2218 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:24:09 INFO - PROCESS | 2218 | 2017-01-05 03:24:09.723 plugin-container[2220:28823] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:24:09 INFO - PROCESS | 2218 | __metrics Screen width/height:1600/1200 03:24:09 INFO - PROCESS | 2218 | colorDepth:24 03:24:09 INFO - PROCESS | 2218 | Browser inner width/height: 1024/689 03:24:09 INFO - PROCESS | 2218 | __metrics 03:24:09 ERROR - PROCESS | 2218 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:24:10 INFO - TEST-INFO | 2218: exit 0 03:24:10 INFO - Browser initialized. 03:24:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:10 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpi5uLoY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:13 INFO - PROCESS | 2221 | 2017-01-05 03:24:13.415 plugin-container[2222:28945] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 03:24:13 INFO - PROCESS | 2221 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:24:13 INFO - PROCESS | 2221 | 2017-01-05 03:24:13.417 plugin-container[2222:28945] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x890b, name = 'com.apple.CFPasteboardClient' 03:24:13 INFO - PROCESS | 2221 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:24:13 INFO - PROCESS | 2221 | 2017-01-05 03:24:13.417 plugin-container[2222:28945] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:24:23 INFO - PROCESS | 2221 | RSS: Main: 229752832 03:24:23 INFO - PROCESS | 2221 | 03:27:26 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:59943/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59943/tests/dromaeo/cssquery-ext.html) 03:27:27 INFO - PROCESS | 2221 | RSS: Main: 232837120 03:27:27 INFO - PROCESS | 2221 | 03:30:30 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:59943/tests/dromaeo/cssquery-ext.html (next: http://localhost:59943/tests/dromaeo/cssquery-jquery.html) 03:30:30 INFO - PROCESS | 2221 | RSS: Main: 243884032 03:30:30 INFO - PROCESS | 2221 | 03:33:32 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:59943/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59943/tests/dromaeo/cssquery-mootools.html) 03:33:33 INFO - PROCESS | 2221 | RSS: Main: 250007552 03:33:33 INFO - PROCESS | 2221 | 03:36:35 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:59943/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59943/tests/dromaeo/cssquery-prototype.html) 03:36:35 INFO - PROCESS | 2221 | RSS: Main: 249167872 03:36:35 INFO - PROCESS | 2221 | 03:39:38 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:59943/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59943/tests/dromaeo/cssquery-yui.html) 03:39:39 INFO - PROCESS | 2221 | RSS: Main: 252727296 03:39:39 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | Cycle 1(1): loaded http://localhost:59943/tests/dromaeo/cssquery-yui.html (next: http://localhost:59943/tests/dromaeo/cssquery-dojo.html) 03:42:42 INFO - PROCESS | 2221 | RSS: Main: 255279104 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | __start_tp_report 03:42:42 INFO - PROCESS | 2221 | _x_x_mozilla_page_load 03:42:42 INFO - PROCESS | 2221 | _x_x_mozilla_page_load_details 03:42:42 INFO - PROCESS | 2221 | |i|pagename|runs| 03:42:42 INFO - PROCESS | 2221 | |0;dojo.html;3153.7161655451005;3230.5154226865984;3346.2805496818196;3367.1582104473882;3425.828708564571;5777.855553611156;5857.4435428634315;5858;5868.383819698929;5877.559183061271;5823.883522329551;5841.474267315941;5876.764929402819;5878.794242201524;5910.88178236435;4473.955260447403;5295.655782374152;5308.495692909187;5321.3348331458565;5341.332333458317;5372.838814835562;5374.865628359284;5408.945910540903;5409.134538473845;5439.809606663767;5256.526912577867;5261.447548007462;5358.2498450217;5380.757865896044;5381.757820898049;5260.55285300748;5305.442928492511;5332.066888294533;5337.893242135136;5376.650517716336;5173.327467429248;5276.498732620395;5291.206319052173;5323.201519772065;5360.142377219665;4819.759012049383;4868.707877527359;4959.380077490314;6006.729697163638;6033.004554248544;5366.738816378148;6042.848928776772;6217.2539295284405;6263.655498947556;6271.059341098826;5154;6141.355157708465;6166.105914642351;6244.250689917239;6277.403646653561;4731.550502702238;5845.766169353221;5878.059510478303;5920.496757775594;5971.104334349882;6274;6317.241930968313;6327.873442531216;6367.204099487564;6378.298387177407;6133.539984501181;6220.377962203744;6222.222222222223;6237.625742455467;6244.0321750128805;6093.69531523422;6167.599106058092;6253;6287.748490060438;6300.621962682254;6163.19878415803;6188.938110618927;6198.349173336825;6204.100405441186;6252.437280644764;6214.40963108513;6252.562320637603;6262.749490020439;6263.029230469285;6287;4876.5854902332985;4944.826931057396;4947.925781113287;4962.652614316963;5007.949920500749;4416.955830441719;4457.353683715908;4473.910521789546;4492.2587773017085;4502.639788816952;5658.321001479849;5930.140129681258;5933.792317268962;5987.970060149672;5989.55078369124;6151.692415379213;6221.191245138193;6232.594881332699;6237.220347456568;6250.312465628777;5805.477507024388;5929.0513517836935;5962.910556341659;5975.760969561169;6027.939720602738;5444.754986025639;5486.643368181056;5502.064649009678;5504.394516603171;5523.6409633373705;6216.658083805253;6270.15352927349;6307.590006649553;6423.518236132309;6428.260750013715;6181.96909015452;6270.278917924497;6279.686015699288;6280.403361680633;6295.653739044214;6400.39196276353;6417.39034791694;6454.031895215755;6455.064015717789;6469.77355792545;6114.297368146176;6157.507399408126;6260.906086408799;6270.2475702915945;6271.529635277281;6178.104174894705;6182.845428864314;6231.657258850807;6243.969744992026;6279.811605651837;6043.516518678583;6177.6293422393;6202.162708034358;6249.8750024998335;6250.624962502265;4783.067301876101;6090.817275481742;6227.50179985591;6229.408206220402;6231.844203894939;5893.941060589339;5938.376470470538;6008.1588577598295;6074.3318234994995;6094.8171554853425;5373.462653734595;5869.4717475427415;6214.316425193135;6221.222347206599;6248.812535623939;6111.236095488064;6115.082737589397;6124.173236613;6141.785037523665;6152.107944348134 03:42:42 INFO - PROCESS | 2221 | |1;ext.html;460.3761902621947;462.44968487499875;494.18459541756096;497.0233491189811;516.8061976758715;38078.428823567636;39853.80073099634;40055.59944400555;41734.373984390186;41931.58068419315;40405;40938;41061;41092.767216983535;41110.38334424986;9333.5799889005;9511.952440237823;9533.856992145124;9544.952275238615;9556.378835375679;9502.904970950305;9564.521773911276;9573.856392154088;9587.376820506644;9590.760230994247;9535.28485363597;9558.952205238964;9593.184579310768;9594.184494317991;9608.711738647851;9519.95240023799;9584.760380990496;9588.856167157499;9608.951955240249;9630;9416.293777966679;9439.292053096045;9471.10024547667;9499.050094990514;9517.381370210915;38872.41691374632;39178.60821391778;39270;39335.21329573421;39337.60662393368;3459.238967427162;3493.074335301147;3512;3725.720570957189;3962.6829853611644;28987.56518652201;29415.2646183845;29487.230329949256;30048.69951300481;30068.699313006808;2982.7315541601142;3065.494193458099;3074.4158609864053;3085.969140308591;3115.6417012043453;320087;321341;321920;322014;322916;51088.48911510837;60381;60450.69774651099;60856.695716521135;61037.38962610406;62572.687136564025;63588.68205659035;63855.36144638587;63866.36133638604;64019.6799016002;16163.595910102342;16400.26198821032;16419.507414777574;16419.507414777574;16475.093869837274;12589;12649.747005059848;12651.493940242472;12659.303738294298;12664.556740514037;14671.77992330116;15939.760903586455;18406.447806565557;18429.525637948933;18491.44525664205;6569.540132190797;7810.843783124305;7934.166912474223;7969.645160322759;8027.397945154137;803.6624617660597;842.5113434208145;911.2345629671108;969.4377261188494;991.2218908157062;24403.63394549083;29686.55470167949;29802.254943626584;29859.552106718416;30155;926.9675561355455;1044.8611013994782;1104.2877344113;1108.38484641025;1136.465861045324;12236.694082648006;15112.622184445258;15288.923555382375;15470.226488675522;15648.4523041693;642415;647469;648056.7597161984;648075;648144;53867.73066134644;53949.73025134849;54251.72874135604;54499.18251226235;54562.72718636461;1315.7302752935625;1337.7458282926214;1367.8905687544973;1369.3221855181748;1392.394308475796;28371.290717732223;28535.571966420935;29103.7089629101;29312.853435732686;29313.267168320108;39693.404598930465;48243.5175648239;49063;49132.26301605407;49242;543454;575131;576124;578643;579240.1037994783;21419;21455;21749.34751957444;21756.45608859728;26365.868170659025;43373.34939975966;45107.323390148515;45572.08855822931;46153.76923115363;46259;37346.11352403818;37643.623563765104;37838;38678.6132138675;39317.213655726155;34411.13972150716;37789.81105094567;38290.42564361481;38586.614133859424;39064;30975.0707478776;34610;36933;37480.06299842526;39360.80319598383;25859.741402585732;32412.351752964336;33235.50146747752;34654.82672586621;34765;21386.679199812326;25384.857681404752;25951.091711789995;25960.350991225372;26374.736252637995 03:42:42 INFO - PROCESS | 2221 | |2;jquery.html;305.95563643271726;363.4366731566072;372.10323121277725;375.46871177284146;397.6778809164577;18446.26214951402;18457.723134153;18566.443006709786;18609.90695046523;18940.24239030439;16423.83576164241;19326.420207393767;19531.316403925866;19905.800941990576;20288.49278768028;5805.448482394177;6035.034394496882;6051.1830902828215;6056.818295451121;6068.453839154476;5625.268715067056;5896.321922978869;5921.674307913063;5947.6134051286745;5955;5594.720263986805;5842.795502157425;5874.73563689635;5883.117532370136;5890.793822216223;5673.347565030012;5782.190493330937;5791.507721843648;5796.275465566804;5811.302643682743;4983.053219888209;5004.124278251292;5023.422306434771;5026.5727413169925;5034.0686972910125;20863.165473381046;23002.654960175612;24398.512029759484;24565.38586535333;24686.259412217663;2381.6189409694366;2415.516896620683;2801.719828017182;3048.6798886116862;3054.3585846972164;14963.326650300764;15050.623734406618;15106.697866042727;15131.621709457242;15769.29038193284;1785.4911350265113;1830.3776715916651;1859.7489338939206;1871.23279455424;1876.502726777405;116765;117351;120705;122291;123247;10581.947090264499;10756.462176891124;11159.27464714791;11421.955065037577;11623.825642615368;13822.101563398346;13952.232627205602;13954;13954.23251721165;13961;7398.852022959511;8297.875531867026;8489.533075680773;8630.870536941951;8694.869576956224;6869.7595584155315;7220.819479512949;8555.529445880411;8773.341999350074;9191.494467804336;5774.931637647049;6665.233498147678;6715.160604924385;6761.357671021246;6807.353301436356;1544.8104959181367;1729.7751292331916;1801.8108098649716;1805.1966874740615;1811.7644706188112;708.2492557888654;860.6858496648678;877.8463768840427;947.4126041854095;1007.1690855044618;20314.593708125754;21045.579088418144;21801.345959621238;21831.126754929624;21997.67003494949;831.5925196653596;887.0242732993655;918.8070505193984;949.6960972488737;992.667456402099;10949.671509854717;11602;11728.354940478184;11744.882551174378;11747.706307342385;574496;580986;588609;591269.2029075944;591311;117758.41120794341;120696;123529;125057.74942250643;135637.3218133903;419.7607363802603;446.3995925480224;447.13925693040767;447.2486223145082;448.2894612039888;11084.778304433705;11113.888611138822;11148.777024459627;11177.832332514856;11397.259178153394;52268.73865630647;52607.73696131495;52902;54224;56867.431325686215;54993.72503137459;67846.66076669584;70122.29877701362;76071.61964190366;78311;8005.879911801211;8126.55303958288;8225.629846657035;8365.414420990472;8532.445391049561;8522.659093636184;11230.3261804292;11548.94225528867;12906.483740650268;12932.159409638343;10985.725356865823;11034.779304413707;11330.263532870336;11352.602658906899;11352.772944541228;10199.13307368882;10538.683839484827;10896.673099807018;11049.5027723751;11143.052840508648;9825.705228843146;11502.079833613458;11523.135764817505;11612.76774464489;11653.067754579444;7731.806704832424;7900.68397264126;8173.509589424653;8266.958665206635;8267.751967440987;7965.641546130322;10795.29830561011;10856.402897840695;11107.944745249188;11223.102151827998 03:42:42 INFO - PROCESS | 2221 | |3;mootools.html;1445.681949971006;1468.3392473386975;1656.7929008873891;1749.7462867884149;1814.41031664709;5945.524358051356;7134.821629459253;8002.639881205345;8458.238758511732;8476.788080297996;8019.959900200505;8306.75079747607;8327.250547450729;8391.580420978942;8399.580020998956;1920.6350793349218;2231.386368748591;2274.0903638544632;2278.1912421090524;2279.5782780185637;2311.838171328008;2342.4495243617735;2352.9529409411803;2356.964645530318;2363.2201373546773;2282.224043825099;2300.3903965449167;2320.2575175943703;2323.6398358254496;2331.8134549236106;1702.6509565539159;1864.3567969050655;2284.794368506834;2315.6642286868396;2317.2121478697322;1749.4401791426749;2098.646373089349;2227.643577027684;2337.6960995070704;2351.6002279612508;8328.583570821434;8342.541160236184;8377.874331885027;8423;8428.241458268723;3881.6894648428342;5217.113090774577;5224.973875130638;5229.346331708536;5286.154215325568;2974.6876577959433;3220.339830334776;3297.258116923697;3370.4775759757276;3417.9829100854586;993.7565296502331;1023.6059117239841;1028.2442404832443;1034.095166729112;1041.536516250269;10873.401962892038;10985.450727463594;10987.890121098846;10998.890011099867;11019.669409917715;4577.610903073276;4752.572268495852;4771.832985845479;4787.090452814024;4793.736344501016;8340.582970851434;8653.610587523577;8684.913150868537;8750.781230469289;8759.605817738217;5077.543021128116;5106.336176297132;5130.820421285312;5130.948690513122;5133.358330208724;4583;4667.416572928384;4739.810407583727;4743.478217396084;4778.187708089564;3634.945475817865;3681;3724.9627503724614;3746.28820524105;3780.281746468162;1156.8958793708607;1158.530795028015;1167.0605162843822;1170.3212136960542;1174.8413964114907;638.9073584330339;810.9026916770025;819.6311659753135;826.1325608111459;879.2702057292432;5413.404525502192;5554.666719996813;5622.409646987089;5705.486506214377;5758.107493338539;433.7701018460221;447.95296493868324;451.69059194451904;455.4921262792029;456.78302806166806;3749.343864823645;3753.211825516672;3850.2492014057552;3854.71089668276;3881.9611803882162;9787.510624468749;10251.436171010517;10282.948585257025;10303.3817970922;10334.741631459274;10205.846912296322;10235.948820255851;10260.230482713827;10264.486775661187;10286.2799604027;7618.923810761932;7714.344280736088;7733.729319473791;7954.960225198953;7957.045154581603;5195.272661827272;5495.862603434946;5542.7782888684005;5695.971520142372;5708.65748055118;9079.547272436379;9120.087991200828;9157.221636161;9219.953900230455;9402.905970940477;8642.524661143698;9043.728688139367;9449.527523623929;9635.277354198322;9672.274579406714;6979.232284448808;7227.349538541346;7233.746818861315;7236;7249.347558719741;7635.847283054197;7847.646855891613;7889.447738658469;7991.200879912195;8010.118886922317;7126.821829454305;7210.783676489714;7225.674844631899;7243.601601911945;7298.306660867209;6322.905156422566;7051.224365319913;7103.893441598483;7125;7132.358087772125;6688.899666505104;6700.765473208415;6721.428678562377;6739.764108256188;6740.831479212863;4807.735574543433;4823.758812059313;4852.975735121302;4861;4918.065567542156;4771.71369717818;4853.878653033561;4856.63575231852;4897.142999975062;5007.974960125176 03:42:42 INFO - PROCESS | 2221 | |4;prototype.html;282.27455439520435;296.7670378752678;299.0072957780168;299.80812280140714;309.34419031652897;4249.936250956238;4610.262358022717;4760.785764640591;4988.925166122506;5384.246205531219;5201.973990130044;5343.305370301865;5353.304070470843;5370.3287089113865;5374.758135883885;3777.3956167013284;4126.773027483495;4168.312228482312;4190.2248084104385;4193.238839687323;3784.5807822066727;4038.6567141792984;4148.502179738435;4159.438475805758;4183.937240941388;3338.5492958450664;4043.2115737431213;4045.858394956177;4053.5338436079933;4078.1232035112444;3715.2198038411966;3719.274741425423;4065.79671016448;4074.22589707956;4092.1611069730634;3272.443684573628;3528.6767462201674;3532.788032718045;3542.2384187399834;3549.94675079874;4731.881702957454;4934.950650493485;5114.744262786883;5147.6911385317;5224.791008359661;3951.288768021755;4307.569243075699;4583.427071616048;4609.308603709437;4627.120847039052;4857.392825896763;5294.96748134114;5618.831435056954;5629.437056294379;5649.971750141223;3706.9426468310076;3831.961680383188;3860.942085868714;3865.3042452358563;3873.973397049784;4730.763461826895;4746.1931471649905;5080.348886611866;5669.404712505168;5902.822915312548;3616.7214654767326;3865.8840234793;3908.7459315144424;3957.3074711925874;3991.44119823225;3798.3163030654196;3938.448617193595;3947.013246688328;3961.267165574378;3989.8204580793936;3624.3657359961903;4209.536950935395;4552.453705555355;4561.635069194456;4569.725816451024;4960.826371076995;5333.839984800462;5707.200991861143;5737.41007194243;5750.6262092963825;1101.5043230546287;1211.4185191108318;1239.2936026465009;1243.9564615238605;1266.5060626355728;759.9582022988789;779.8713212320017;867.3754896474528;868.5136323658771;869.7260362985639;4473.664475164311;4535.63714902807;4622.602387245372;4767.976160119178;4834.7824347904425;5193.896122077613;5368.892622147535;5538.44615538451;5581.274434323512;5588.860278492989;4731.526847315241;4789.449213340441;4854.83008094722;5069.746512674352;5132.589392848563;2418.600930846391;2566.242958327298;2669.8398096114297;2910.57796619489;2952.4242772659127;5442.8911421771345;5754.4533269339345;5757.222774925415;5790.652560846363;5866.386743645532;5325.4142044375085;5466.617336786387;5708.915306091829;5755.65466072037;5771.307443106854;5292.52367286946;5604.187392828017;5638.689872057076;5781.971090144522;5805.880853488531;4349.739015659071;5254.5533629641905;5375.731213439234;5625.774969001194;5637.956977959091;4997.503744383424;5271.393789714232;5498.917516237179;5547.55619550443;5563.248961390323;5225.1189571753375;5561.138023606348;5663.329317851326;5797.362290148165;5837.8540536485225;3316.6517515660507;3714.145746478271;3736.4208547675153;3744.9063773405883;3753.887383378503;5104.387473503203;5152.377001244596;5236.581073514034;5479.753411096431;5495.323926202387;5218.746721422029;5487.917681234864;5541.944580554143;5611.551075913835;5689.212285979923;5456.672599644034;5745.075399741134;5756.683382414008;5815.975692639889;5845.41545845412;4471.069841745347;5061.772220250024;5309.637211440871;5391.433899440659;5700.600957932905;4343.587359200871;4590.265557510782;5492.47821456961;5771.480566749013;5778.248827652546;5243.528082472596;5596.580256480699;5633.690147041788;5645.137104755503;5672.688002159921 03:42:42 INFO - PROCESS | 2221 | |5;yui.html;617.9598326108803;640.6540468147201;685.7930043124103;698.2040473859797;757.1746795992369;12642.367881605905;13906;14414.270287565507;14816.703665926674;14865.479708210214;10627.41549214793;11696.473658685358;12936.029797765183;12939;12950.35248237589;642.4828013449171;667.0694381338055;803.4536515169697;817.599376305609;820.7086484298048;775.7207405334075;809.6882700160451;812.3095368936416;818.5129847740615;821.8726097454904;837.3552364679193;837.6523742646795;838.5220424358088;839.7690635075342;840.3949156607233;833.3624777045565;833.5873742497472;835.4527784301262;836.6318819719335;846.4159729786489;564.3199944067389;604.5103466192398;626.9811905642838;629.1412222316505;629.2574761781096;13798.310084495835;13856.030077894551;13866.653333666638;13869.791953120712;13873.306334683226;10972;13046.608601741962;13522.594322170351;13589.252591107484;13652.453901843914;10962.287451315638;11064.336139831556;11195.60815371458;11431.199816012882;11567.363794991355;3556.733245006609;3652.196516766334;3708.332500149972;3758.906027349311;3770.019794853358;59125.7043714783;61732;69398.9590156148;71130;75493.62253188754;8797.516136612549;9172.495512746864;9733.805323893483;10467.110295624805;10558.260921735558;14961.850381496046;19590.21639134447;20158.89920550388;20207.898960505398;20248.89875550613;7125.89311160333;7664.233576642403;7679.808004799925;7798.1811909749795;7857.371410287164;4204.348326009474;4268;4311.310190369526;4375;4417.293233082692;2916.7958242923214;3005.7294843463756;3379.4086034943784;3404;3448.2930999145115;621.5959626242887;621.6984762390238;624.3506752976944;636.0554576453962;636.239693566184;572.4761842913771;627.4541149200134;653.3401264722664;659.2128223356846;677.3260605697362;8830.823383532294;8945.15021072997;9022.909770902339;9118.088191180961;9621.27840411972;639.4916041746823;641.6118248459708;651.7327895562796;667.0827612033454;669.2303850571881;4328.567143285646;4333.653307735373;4469.524383982296;4476.462824461086;4506.842260520932;99027.50486247666;116583.41708291574;118519;119309;121898.39050804867;81064.59467702742;104817.33139340239;105169;105923;110852;92172.53913730389;93578.59632105524;94816;95197.5240123795;95265;7939.523628582304;8719.171678690767;8797.340199484936;8896.911030889609;9026.465500864737;59792.10311845413;60205.69897150486;60218.69890650519;60370.698146510746;62684.059739104865;79335.60332198303;83474;84241.57879210565;84258.57870710608;86539;12196.939015304866;12214.529604429188;12263.141580089308;12328.32194229326;12559.560415385418;11807.350595717318;14084.577462676136;14324;14521.34653940554;14589.562313130624;12583.370831458573;12594.496220151092;12812.743745125232;13139.277339746406;13309.267990260241;12687.302198379179;12975.156614820007;13213.546509884098;13438.865611343761;13653.996884642826;12705.745885082062;12932.93533532364;13168.473261069834;13212.603621891358;13795.241261730702;10460.21548383859;10680.092192163753;11443.656690299304;11559.30644161353;11614.593489227836;11229;11324.716882077684;11425.828612570984;11610.477528511406;11658.00906922887 03:42:42 INFO - PROCESS | 2221 | __end_tp_report 03:42:42 INFO - PROCESS | 2221 | __start_cc_report 03:42:42 INFO - PROCESS | 2221 | _x_x_mozilla_cycle_collect,378 03:42:42 INFO - PROCESS | 2221 | __end_cc_report 03:42:42 INFO - PROCESS | 2221 | __startTimestamp1483616562666__endTimestamp 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | ------- Summary: start ------- 03:42:42 INFO - PROCESS | 2221 | Number of tests: 6 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | [#0] dojo.html Cycles:165 Average:5770.03 Median:6033.00 stddev:669.16 (11.1%) stddev-sans-first:638.96 03:42:42 INFO - PROCESS | 2221 | Values: 3153.7 3230.5 3346.3 3367.2 3425.8 5777.9 5857.4 5858.0 5868.4 5877.6 5823.9 5841.5 5876.8 5878.8 5910.9 4474.0 5295.7 5308.5 5321.3 5341.3 5372.8 5374.9 5408.9 5409.1 5439.8 5256.5 5261.4 5358.2 5380.8 5381.8 5260.6 5305.4 5332.1 5337.9 5376.7 5173.3 5276.5 5291.2 5323.2 5360.1 4819.8 4868.7 4959.4 6006.7 6033.0 5366.7 6042.8 6217.3 6263.7 6271.1 5154.0 6141.4 6166.1 6244.3 6277.4 4731.6 5845.8 5878.1 5920.5 5971.1 6274.0 6317.2 6327.9 6367.2 6378.3 6133.5 6220.4 6222.2 6237.6 6244.0 6093.7 6167.6 6253.0 6287.7 6300.6 6163.2 6188.9 6198.3 6204.1 6252.4 6214.4 6252.6 6262.7 6263.0 6287.0 4876.6 4944.8 4947.9 4962.7 5007.9 4417.0 4457.4 4473.9 4492.3 4502.6 5658.3 5930.1 5933.8 5988.0 5989.6 6151.7 6221.2 6232.6 6237.2 6250.3 5805.5 5929.1 5962.9 5975.8 6027.9 5444.8 5486.6 5502.1 5504.4 5523.6 6216.7 6270.2 6307.6 6423.5 6428.3 6182.0 6270.3 6279.7 6280.4 6295.7 6400.4 6417.4 6454.0 6455.1 6469.8 6114.3 6157.5 6260.9 6270.2 6271.5 6178.1 6182.8 6231.7 6244.0 6279.8 6043.5 6177.6 6202.2 6249.9 6250.6 4783.1 6090.8 6227.5 6229.4 6231.8 5893.9 5938.4 6008.2 6074.3 6094.8 5373.5 5869.5 6214.3 6221.2 6248.8 6111.2 6115.1 6124.2 6141.8 6152.1 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | [#1] ext.html Cycles:180 Average:64831.53 Median:39326.21 stddev:142423.96 (362.2%) stddev-sans-first:142741.49 03:42:42 INFO - PROCESS | 2221 | Values: 460.4 462.4 494.2 497.0 516.8 38078.4 39853.8 40055.6 41734.4 41931.6 40405.0 40938.0 41061.0 41092.8 41110.4 9333.6 9512.0 9533.9 9545.0 9556.4 9502.9 9564.5 9573.9 9587.4 9590.8 9535.3 9559.0 9593.2 9594.2 9608.7 9520.0 9584.8 9588.9 9609.0 9630.0 9416.3 9439.3 9471.1 9499.1 9517.4 38872.4 39178.6 39270.0 39335.2 39337.6 3459.2 3493.1 3512.0 3725.7 3962.7 28987.6 29415.3 29487.2 30048.7 30068.7 2982.7 3065.5 3074.4 3086.0 3115.6 320087.0 321341.0 321920.0 322014.0 322916.0 51088.5 60381.0 60450.7 60856.7 61037.4 62572.7 63588.7 63855.4 63866.4 64019.7 16163.6 16400.3 16419.5 16419.5 16475.1 12589.0 12649.7 12651.5 12659.3 12664.6 14671.8 15939.8 18406.4 18429.5 18491.4 6569.5 7810.8 7934.2 7969.6 8027.4 803.7 842.5 911.2 969.4 991.2 24403.6 29686.6 29802.3 29859.6 30155.0 927.0 1044.9 1104.3 1108.4 1136.5 12236.7 15112.6 15288.9 15470.2 15648.5 642415.0 647469.0 648056.8 648075.0 648144.0 53867.7 53949.7 54251.7 54499.2 54562.7 1315.7 1337.7 1367.9 1369.3 1392.4 28371.3 28535.6 29103.7 29312.9 29313.3 39693.4 48243.5 49063.0 49132.3 49242.0 543454.0 575131.0 576124.0 578643.0 579240.1 21419.0 21455.0 21749.3 21756.5 26365.9 43373.3 45107.3 45572.1 46153.8 46259.0 37346.1 37643.6 37838.0 38678.6 39317.2 34411.1 37789.8 38290.4 38586.6 39064.0 30975.1 34610.0 36933.0 37480.1 39360.8 25859.7 32412.4 33235.5 34654.8 34765.0 21386.7 25384.9 25951.1 25960.4 26374.7 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | [#2] jquery.html Cycles:180 Average:34179.78 Median:2925.20 stddev:97739.07 (3341.3%) stddev-sans-first:97980.16 03:42:42 INFO - PROCESS | 2221 | Values: 306.0 363.4 372.1 375.5 397.7 18446.3 18457.7 18566.4 18609.9 18940.2 16423.8 19326.4 19531.3 19905.8 20288.5 5805.4 6035.0 6051.2 6056.8 6068.5 5625.3 5896.3 5921.7 5947.6 5955.0 5594.7 5842.8 5874.7 5883.1 5890.8 5673.3 5782.2 5791.5 5796.3 5811.3 4983.1 5004.1 5023.4 5026.6 5034.1 20863.2 23002.7 24398.5 24565.4 24686.3 2381.6 2415.5 2801.7 3048.7 3054.4 14963.3 15050.6 15106.7 15131.6 15769.3 1785.5 1830.4 1859.7 1871.2 1876.5 116765.0 117351.0 120705.0 122291.0 123247.0 10581.9 10756.5 11159.3 11422.0 11623.8 13822.1 13952.2 13954.0 13954.2 13961.0 7398.9 8297.9 8489.5 8630.9 8694.9 6869.8 7220.8 8555.5 8773.3 9191.5 5774.9 6665.2 6715.2 6761.4 6807.4 1544.8 1729.8 1801.8 1805.2 1811.8 708.2 860.7 877.8 947.4 1007.2 20314.6 21045.6 21801.3 21831.1 21997.7 831.6 887.0 918.8 949.7 992.7 10949.7 11602.0 11728.4 11744.9 11747.7 574496.0 580986.0 588609.0 591269.2 591311.0 117758.4 120696.0 123529.0 125057.7 135637.3 419.8 446.4 447.1 447.2 448.3 11084.8 11113.9 11148.8 11177.8 11397.3 52268.7 52607.7 52902.0 54224.0 56867.4 54993.7 67846.7 70122.3 76071.6 78311.0 8005.9 8126.6 8225.6 8365.4 8532.4 8522.7 11230.3 11548.9 12906.5 12932.2 10985.7 11034.8 11330.3 11352.6 11352.8 10199.1 10538.7 10896.7 11049.5 11143.1 9825.7 11502.1 11523.1 11612.8 11653.1 7731.8 7900.7 8173.5 8267.0 8267.8 7965.6 10795.3 10856.4 11107.9 11223.1 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | [#3] mootools.html Cycles:180 Average:5386.02 Median:4879.07 stddev:3005.65 (61.6%) stddev-sans-first:2999.49 03:42:42 INFO - PROCESS | 2221 | Values: 1445.7 1468.3 1656.8 1749.7 1814.4 5945.5 7134.8 8002.6 8458.2 8476.8 8020.0 8306.8 8327.3 8391.6 8399.6 1920.6 2231.4 2274.1 2278.2 2279.6 2311.8 2342.4 2353.0 2357.0 2363.2 2282.2 2300.4 2320.3 2323.6 2331.8 1702.7 1864.4 2284.8 2315.7 2317.2 1749.4 2098.6 2227.6 2337.7 2351.6 8328.6 8342.5 8377.9 8423.0 8428.2 3881.7 5217.1 5225.0 5229.3 5286.2 2974.7 3220.3 3297.3 3370.5 3418.0 993.8 1023.6 1028.2 1034.1 1041.5 10873.4 10985.5 10987.9 10998.9 11019.7 4577.6 4752.6 4771.8 4787.1 4793.7 8340.6 8653.6 8684.9 8750.8 8759.6 5077.5 5106.3 5130.8 5130.9 5133.4 4583.0 4667.4 4739.8 4743.5 4778.2 3634.9 3681.0 3725.0 3746.3 3780.3 1156.9 1158.5 1167.1 1170.3 1174.8 638.9 810.9 819.6 826.1 879.3 5413.4 5554.7 5622.4 5705.5 5758.1 433.8 448.0 451.7 455.5 456.8 3749.3 3753.2 3850.2 3854.7 3882.0 9787.5 10251.4 10282.9 10303.4 10334.7 10205.8 10235.9 10260.2 10264.5 10286.3 7618.9 7714.3 7733.7 7955.0 7957.0 5195.3 5495.9 5542.8 5696.0 5708.7 9079.5 9120.1 9157.2 9220.0 9402.9 8642.5 9043.7 9449.5 9635.3 9672.3 6979.2 7227.3 7233.7 7236.0 7249.3 7635.8 7847.6 7889.4 7991.2 8010.1 7126.8 7210.8 7225.7 7243.6 7298.3 6322.9 7051.2 7103.9 7125.0 7132.4 6688.9 6700.8 6721.4 6739.8 6740.8 4807.7 4823.8 4853.0 4861.0 4918.1 4771.7 4853.9 4856.6 4897.1 5008.0 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | [#4] prototype.html Cycles:180 Average:4458.16 Median:4974.88 stddev:1373.96 (27.6%) stddev-sans-first:1341.59 03:42:42 INFO - PROCESS | 2221 | Values: 282.3 296.8 299.0 299.8 309.3 4249.9 4610.3 4760.8 4988.9 5384.2 5202.0 5343.3 5353.3 5370.3 5374.8 3777.4 4126.8 4168.3 4190.2 4193.2 3784.6 4038.7 4148.5 4159.4 4183.9 3338.5 4043.2 4045.9 4053.5 4078.1 3715.2 3719.3 4065.8 4074.2 4092.2 3272.4 3528.7 3532.8 3542.2 3549.9 4731.9 4935.0 5114.7 5147.7 5224.8 3951.3 4307.6 4583.4 4609.3 4627.1 4857.4 5295.0 5618.8 5629.4 5650.0 3706.9 3832.0 3860.9 3865.3 3874.0 4730.8 4746.2 5080.3 5669.4 5902.8 3616.7 3865.9 3908.7 3957.3 3991.4 3798.3 3938.4 3947.0 3961.3 3989.8 3624.4 4209.5 4552.5 4561.6 4569.7 4960.8 5333.8 5707.2 5737.4 5750.6 1101.5 1211.4 1239.3 1244.0 1266.5 760.0 779.9 867.4 868.5 869.7 4473.7 4535.6 4622.6 4768.0 4834.8 5193.9 5368.9 5538.4 5581.3 5588.9 4731.5 4789.4 4854.8 5069.7 5132.6 2418.6 2566.2 2669.8 2910.6 2952.4 5442.9 5754.5 5757.2 5790.7 5866.4 5325.4 5466.6 5708.9 5755.7 5771.3 5292.5 5604.2 5638.7 5782.0 5805.9 4349.7 5254.6 5375.7 5625.8 5638.0 4997.5 5271.4 5498.9 5547.6 5563.2 5225.1 5561.1 5663.3 5797.4 5837.9 3316.7 3714.1 3736.4 3744.9 3753.9 5104.4 5152.4 5236.6 5479.8 5495.3 5218.7 5487.9 5541.9 5611.6 5689.2 5456.7 5745.1 5756.7 5816.0 5845.4 4471.1 5061.8 5309.6 5391.4 5700.6 4343.6 4590.3 5492.5 5771.5 5778.2 5243.5 5596.6 5633.7 5645.1 5672.7 03:42:42 INFO - PROCESS | 2221 | 03:42:42 INFO - PROCESS | 2221 | [#5] yui.html Cycles:180 Average:20865.70 Median:4396.15 stddev:31213.56 (710.0%) stddev-sans-first:31264.10 03:42:42 INFO - PROCESS | 2221 | Values: 618.0 640.7 685.8 698.2 757.2 12642.4 13906.0 14414.3 14816.7 14865.5 10627.4 11696.5 12936.0 12939.0 12950.4 642.5 667.1 803.5 817.6 820.7 775.7 809.7 812.3 818.5 821.9 837.4 837.7 838.5 839.8 840.4 833.4 833.6 835.5 836.6 846.4 564.3 604.5 627.0 629.1 629.3 13798.3 13856.0 13866.7 13869.8 13873.3 10972.0 13046.6 13522.6 13589.3 13652.5 10962.3 11064.3 11195.6 11431.2 11567.4 3556.7 3652.2 3708.3 3758.9 3770.0 59125.7 61732.0 69399.0 71130.0 75493.6 8797.5 9172.5 9733.8 10467.1 10558.3 14961.9 19590.2 20158.9 20207.9 20248.9 7125.9 7664.2 7679.8 7798.2 7857.4 4204.3 4268.0 4311.3 4375.0 4417.3 2916.8 3005.7 3379.4 3404.0 3448.3 621.6 621.7 624.4 636.1 636.2 572.5 627.5 653.3 659.2 677.3 8830.8 8945.2 9022.9 9118.1 9621.3 639.5 641.6 651.7 667.1 669.2 4328.6 4333.7 4469.5 4476.5 4506.8 99027.5 116583.4 118519.0 119309.0 121898.4 81064.6 104817.3 105169.0 105923.0 110852.0 92172.5 93578.6 94816.0 95197.5 95265.0 7939.5 8719.2 8797.3 8896.9 9026.5 59792.1 60205.7 60218.7 60370.7 62684.1 79335.6 83474.0 84241.6 84258.6 86539.0 12196.9 12214.5 12263.1 12328.3 12559.6 11807.4 14084.6 14324.0 14521.3 14589.6 12583.4 12594.5 12812.7 13139.3 13309.3 12687.3 12975.2 13213.5 13438.9 13654.0 12705.7 12932.9 13168.5 13212.6 13795.2 10460.2 10680.1 11443.7 11559.3 11614.6 11229.0 11324.7 11425.8 11610.5 11658.0 03:42:42 INFO - PROCESS | 2221 | -------- Summary: end -------- 03:42:42 INFO - PROCESS | 2221 | 03:42:43 INFO - TEST-INFO | 2221: exit 0 03:42:43 INFO - TEST-OK | dromaeo_css | took 1116897ms 03:42:43 INFO - TEST-START | kraken 03:42:43 INFO - operating with platform_type : mac_ 03:42:43 INFO - Initialising browser for kraken test... 03:42:43 INFO - TEST-INFO | started process 2249 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpj1kgJh/profile http://localhost:59943/getInfo.html) 03:42:46 INFO - PROCESS | 2249 | 2017-01-05 03:42:46.502 plugin-container[2250:31209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853f, name = 'com.apple.tsm.portname' 03:42:46 INFO - PROCESS | 2249 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:42:46 INFO - PROCESS | 2249 | 2017-01-05 03:42:46.505 plugin-container[2250:31209] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 03:42:46 INFO - PROCESS | 2249 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:42:46 INFO - PROCESS | 2249 | 2017-01-05 03:42:46.505 plugin-container[2250:31209] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:42:46 INFO - PROCESS | 2249 | __metrics Screen width/height:1600/1200 03:42:46 INFO - PROCESS | 2249 | colorDepth:24 03:42:46 INFO - PROCESS | 2249 | Browser inner width/height: 1024/689 03:42:46 INFO - PROCESS | 2249 | __metrics 03:42:46 ERROR - PROCESS | 2249 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 03:42:47 INFO - TEST-INFO | 2249: exit 0 03:42:47 INFO - Browser initialized. 03:42:47 INFO - Running cycle 1/1 for kraken test... 03:42:47 INFO - TEST-INFO | started process 2251 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/T/tmpj1kgJh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:42:50 INFO - PROCESS | 2251 | 2017-01-05 03:42:50.098 plugin-container[2252:31332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 03:42:50 INFO - PROCESS | 2251 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:42:50 INFO - PROCESS | 2251 | 2017-01-05 03:42:50.099 plugin-container[2252:31332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x870b, name = 'com.apple.CFPasteboardClient' 03:42:50 INFO - PROCESS | 2251 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:42:50 INFO - PROCESS | 2251 | 2017-01-05 03:42:50.099 plugin-container[2252:31332] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:42:59 INFO - PROCESS | 2251 | RSS: Main: 229392384 03:42:59 INFO - PROCESS | 2251 | 03:43:03 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59943/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:04 INFO - PROCESS | 2251 | RSS: Main: 241786880 03:43:04 INFO - PROCESS | 2251 | 03:43:06 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59943/tests/kraken/driver.html?testName=audio-dft) 03:43:07 INFO - PROCESS | 2251 | RSS: Main: 249458688 03:43:07 INFO - PROCESS | 2251 | 03:43:10 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59943/tests/kraken/driver.html?testName=audio-fft) 03:43:11 INFO - PROCESS | 2251 | RSS: Main: 253272064 03:43:11 INFO - PROCESS | 2251 | 03:43:13 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59943/tests/kraken/driver.html?testName=audio-oscillator) 03:43:13 INFO - PROCESS | 2251 | RSS: Main: 253526016 03:43:13 INFO - PROCESS | 2251 | 03:43:16 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59943/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:16 INFO - PROCESS | 2251 | RSS: Main: 253526016 03:43:16 INFO - PROCESS | 2251 | 03:43:19 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59943/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:20 INFO - PROCESS | 2251 | RSS: Main: 257761280 03:43:20 INFO - PROCESS | 2251 | 03:43:23 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59943/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:23 INFO - PROCESS | 2251 | RSS: Main: 258244608 03:43:23 INFO - PROCESS | 2251 | 03:43:26 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59943/tests/kraken/driver.html?testName=json-parse-financial) 03:43:27 INFO - PROCESS | 2251 | RSS: Main: 258064384 03:43:27 INFO - PROCESS | 2251 | 03:43:28 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59943/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:43:29 INFO - PROCESS | 2251 | RSS: Main: 257294336 03:43:29 INFO - PROCESS | 2251 | 03:43:31 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:43:32 INFO - PROCESS | 2251 | RSS: Main: 257327104 03:43:32 INFO - PROCESS | 2251 | 03:43:34 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:43:34 INFO - PROCESS | 2251 | RSS: Main: 257388544 03:43:34 INFO - PROCESS | 2251 | 03:43:37 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:43:38 INFO - PROCESS | 2251 | RSS: Main: 257642496 03:43:38 INFO - PROCESS | 2251 | 03:43:41 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:43:42 INFO - PROCESS | 2251 | RSS: Main: 257593344 03:43:42 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | Cycle 1(1): loaded http://localhost:59943/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59943/tests/kraken/driver.html?testName=ai-astar) 03:43:44 INFO - PROCESS | 2251 | RSS: Main: 259256320 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | __start_tp_report 03:43:44 INFO - PROCESS | 2251 | _x_x_mozilla_page_load 03:43:44 INFO - PROCESS | 2251 | _x_x_mozilla_page_load_details 03:43:44 INFO - PROCESS | 2251 | |i|pagename|runs| 03:43:44 INFO - PROCESS | 2251 | |0;ai-astar;146;162;124;168;173;151;125;107;99;155 03:43:44 INFO - PROCESS | 2251 | |1;audio-beat-detection;140;106;138;142;145;144;137;113;140;112 03:43:44 INFO - PROCESS | 2251 | |2;audio-dft;200;202;200;203;199;198;197;202;197;276 03:43:44 INFO - PROCESS | 2251 | |3;audio-fft;84;59;60;89;60;62;59;60;83;58 03:43:44 INFO - PROCESS | 2251 | |4;audio-oscillator;96;58;116;95;102;101;127;55;103;124 03:43:44 INFO - PROCESS | 2251 | |5;imaging-gaussian-blur;93;93;105;87;90;87;97;129;96;87 03:43:44 INFO - PROCESS | 2251 | |6;imaging-darkroom;100;117;131;102;101;105;100;100;102;103 03:43:44 INFO - PROCESS | 2251 | |7;imaging-desaturate;133;87;89;87;90;88;89;99;90;87 03:43:44 INFO - PROCESS | 2251 | |8;json-parse-financial;59;59;58;62;62;62;62;61;61;60 03:43:44 INFO - PROCESS | 2251 | |9;json-stringify-tinderbox;71;79;83;78;74;68;83;61;74;62 03:43:44 INFO - PROCESS | 2251 | |10;stanford-crypto-aes;81;91;83;74;108;104;79;92;106;105 03:43:44 INFO - PROCESS | 2251 | |11;stanford-crypto-ccm;155;153;141;141;145;143;144;146;215;181 03:43:44 INFO - PROCESS | 2251 | |12;stanford-crypto-pbkdf2;168;169;151;229;232;192;168;173;170;198 03:43:44 INFO - PROCESS | 2251 | |13;stanford-crypto-sha256-iterative;70;65;65;88;89;88;67;69;69;69 03:43:44 INFO - PROCESS | 2251 | __end_tp_report 03:43:44 INFO - PROCESS | 2251 | __start_cc_report 03:43:44 INFO - PROCESS | 2251 | _x_x_mozilla_cycle_collect,968 03:43:44 INFO - PROCESS | 2251 | __end_cc_report 03:43:44 INFO - PROCESS | 2251 | __startTimestamp1483616624389__endTimestamp 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | ------- Summary: start ------- 03:43:44 INFO - PROCESS | 2251 | Number of tests: 14 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#0] ai-astar Cycles:10 Average:141.00 Median:158.50 stddev:25.78 (16.3%) stddev-sans-first:27.28 03:43:44 INFO - PROCESS | 2251 | Values: 146.0 162.0 124.0 168.0 173.0 151.0 125.0 107.0 99.0 155.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:140.00 stddev:15.05 (10.7%) stddev-sans-first:15.66 03:43:44 INFO - PROCESS | 2251 | Values: 140.0 106.0 138.0 142.0 145.0 144.0 137.0 113.0 140.0 112.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#2] audio-dft Cycles:10 Average:207.40 Median:201.00 stddev:24.19 (12.0%) stddev-sans-first:25.51 03:43:44 INFO - PROCESS | 2251 | Values: 200.0 202.0 200.0 203.0 199.0 198.0 197.0 202.0 197.0 276.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#3] audio-fft Cycles:10 Average:67.40 Median:61.00 stddev:12.51 (20.5%) stddev-sans-first:11.74 03:43:44 INFO - PROCESS | 2251 | Values: 84.0 59.0 60.0 89.0 60.0 62.0 59.0 60.0 83.0 58.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:91.00 stddev:24.39 (26.8%) stddev-sans-first:25.86 03:43:44 INFO - PROCESS | 2251 | Values: 96.0 58.0 116.0 95.0 102.0 101.0 127.0 55.0 103.0 124.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:91.50 stddev:12.76 (14.0%) stddev-sans-first:13.48 03:43:44 INFO - PROCESS | 2251 | Values: 93.0 93.0 105.0 87.0 90.0 87.0 97.0 129.0 96.0 87.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#6] imaging-darkroom Cycles:10 Average:106.10 Median:102.50 stddev:10.12 (9.9%) stddev-sans-first:10.49 03:43:44 INFO - PROCESS | 2251 | Values: 100.0 117.0 131.0 102.0 101.0 105.0 100.0 100.0 102.0 103.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:89.00 stddev:14.18 (15.9%) stddev-sans-first:3.75 03:43:44 INFO - PROCESS | 2251 | Values: 133.0 87.0 89.0 87.0 90.0 88.0 89.0 99.0 90.0 87.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:61.50 stddev:1.51 (2.4%) stddev-sans-first:1.48 03:43:44 INFO - PROCESS | 2251 | Values: 59.0 59.0 58.0 62.0 62.0 62.0 62.0 61.0 61.0 60.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:76.00 stddev:7.86 (10.3%) stddev-sans-first:8.29 03:43:44 INFO - PROCESS | 2251 | Values: 71.0 79.0 83.0 78.0 74.0 68.0 83.0 61.0 74.0 62.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#10] stanford-crypto-aes Cycles:10 Average:92.30 Median:80.00 stddev:12.74 (15.9%) stddev-sans-first:12.84 03:43:44 INFO - PROCESS | 2251 | Values: 81.0 91.0 83.0 74.0 108.0 104.0 79.0 92.0 106.0 105.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#11] stanford-crypto-ccm Cycles:10 Average:156.40 Median:149.50 stddev:23.80 (15.9%) stddev-sans-first:25.24 03:43:44 INFO - PROCESS | 2251 | Values: 155.0 153.0 141.0 141.0 145.0 143.0 144.0 146.0 215.0 181.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:182.50 stddev:27.33 (15.0%) stddev-sans-first:28.29 03:43:44 INFO - PROCESS | 2251 | Values: 168.0 169.0 151.0 229.0 232.0 192.0 168.0 173.0 170.0 198.0 03:43:44 INFO - PROCESS | 2251 | 03:43:44 INFO - PROCESS | 2251 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:69.50 stddev:10.10 (14.5%) stddev-sans-first:10.62 03:43:44 INFO - PROCESS | 2251 | Values: 70.0 65.0 65.0 88.0 89.0 88.0 67.0 69.0 69.0 69.0 03:43:44 INFO - PROCESS | 2251 | -------- Summary: end -------- 03:43:44 INFO - PROCESS | 2251 | 03:43:45 INFO - TEST-INFO | 2251: exit 0 03:43:45 INFO - TEST-OK | kraken | took 62105ms 03:43:45 INFO - SUITE-END | took 1179s 03:43:45 INFO - Completed test suite (00:19:39) 03:43:45 INFO - javascript benchmark 03:43:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7076.221936845116, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3153.7161655451005, 3230.5154226865984, 3346.2805496818196, 3367.1582104473882, 3425.828708564571, 5777.855553611156, 5857.4435428634315, 5858.0, 5868.383819698929, 5877.559183061271, 5823.883522329551, 5841.474267315941, 5876.764929402819, 5878.794242201524, 5910.88178236435, 4473.955260447403, 5295.655782374152, 5308.495692909187, 5321.3348331458565, 5341.332333458317, 5372.838814835562, 5374.865628359284, 5408.945910540903, 5409.134538473845, 5439.809606663767, 5256.526912577867, 5261.447548007462, 5358.2498450217, 5380.757865896044, 5381.757820898049, 5260.55285300748, 5305.442928492511, 5332.066888294533, 5337.893242135136, 5376.650517716336, 5173.327467429248, 5276.498732620395, 5291.206319052173, 5323.201519772065, 5360.142377219665, 4819.759012049383, 4868.707877527359, 4959.380077490314, 6006.729697163638, 6033.004554248544, 5366.738816378148, 6042.848928776772, 6217.2539295284405, 6263.655498947556, 6271.059341098826, 5154.0, 6141.355157708465, 6166.105914642351, 6244.250689917239, 6277.403646653561, 4731.550502702238, 5845.766169353221, 5878.059510478303, 5920.496757775594, 5971.104334349882, 6274.0, 6317.241930968313, 6327.873442531216, 6367.204099487564, 6378.298387177407, 6133.539984501181, 6220.377962203744, 6222.222222222223, 6237.625742455467, 6244.0321750128805, 6093.69531523422, 6167.599106058092, 6253.0, 6287.748490060438, 6300.621962682254, 6163.19878415803, 6188.938110618927, 6198.349173336825, 6204.100405441186, 6252.437280644764, 6214.40963108513, 6252.562320637603, 6262.749490020439, 6263.029230469285, 6287.0, 4876.5854902332985, 4944.826931057396, 4947.925781113287, 4962.652614316963, 5007.949920500749, 4416.955830441719, 4457.353683715908, 4473.910521789546, 4492.2587773017085, 4502.639788816952, 5658.321001479849, 5930.140129681258, 5933.792317268962, 5987.970060149672, 5989.55078369124, 6151.692415379213, 6221.191245138193, 6232.594881332699, 6237.220347456568, 6250.312465628777, 5805.477507024388, 5929.0513517836935, 5962.910556341659, 5975.760969561169, 6027.939720602738, 5444.754986025639, 5486.643368181056, 5502.064649009678, 5504.394516603171, 5523.6409633373705, 6216.658083805253, 6270.15352927349, 6307.590006649553, 6423.518236132309, 6428.260750013715, 6181.96909015452, 6270.278917924497, 6279.686015699288, 6280.403361680633, 6295.653739044214, 6400.39196276353, 6417.39034791694, 6454.031895215755, 6455.064015717789, 6469.77355792545, 6114.297368146176, 6157.507399408126, 6260.906086408799, 6270.2475702915945, 6271.529635277281, 6178.104174894705, 6182.845428864314, 6231.657258850807, 6243.969744992026, 6279.811605651837, 6043.516518678583, 6177.6293422393, 6202.162708034358, 6249.8750024998335, 6250.624962502265, 4783.067301876101, 6090.817275481742, 6227.50179985591, 6229.408206220402, 6231.844203894939, 5893.941060589339, 5938.376470470538, 6008.1588577598295, 6074.3318234994995, 6094.8171554853425, 5373.462653734595, 5869.4717475427415, 6214.316425193135, 6221.222347206599, 6248.812535623939, 6111.236095488064, 6115.082737589397, 6124.173236613, 6141.785037523665, 6152.107944348134], "value": 5727.932262877794, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [460.3761902621947, 462.44968487499875, 494.18459541756096, 497.0233491189811, 516.8061976758715, 38078.428823567636, 39853.80073099634, 40055.59944400555, 41734.373984390186, 41931.58068419315, 40405.0, 40938.0, 41061.0, 41092.767216983535, 41110.38334424986, 9333.5799889005, 9511.952440237823, 9533.856992145124, 9544.952275238615, 9556.378835375679, 9502.904970950305, 9564.521773911276, 9573.856392154088, 9587.376820506644, 9590.760230994247, 9535.28485363597, 9558.952205238964, 9593.184579310768, 9594.184494317991, 9608.711738647851, 9519.95240023799, 9584.760380990496, 9588.856167157499, 9608.951955240249, 9630.0, 9416.293777966679, 9439.292053096045, 9471.10024547667, 9499.050094990514, 9517.381370210915, 38872.41691374632, 39178.60821391778, 39270.0, 39335.21329573421, 39337.60662393368, 3459.238967427162, 3493.074335301147, 3512.0, 3725.720570957189, 3962.6829853611644, 28987.56518652201, 29415.2646183845, 29487.230329949256, 30048.69951300481, 30068.699313006808, 2982.7315541601142, 3065.494193458099, 3074.4158609864053, 3085.969140308591, 3115.6417012043453, 320087.0, 321341.0, 321920.0, 322014.0, 322916.0, 51088.48911510837, 60381.0, 60450.69774651099, 60856.695716521135, 61037.38962610406, 62572.687136564025, 63588.68205659035, 63855.36144638587, 63866.36133638604, 64019.6799016002, 16163.595910102342, 16400.26198821032, 16419.507414777574, 16419.507414777574, 16475.093869837274, 12589.0, 12649.747005059848, 12651.493940242472, 12659.303738294298, 12664.556740514037, 14671.77992330116, 15939.760903586455, 18406.447806565557, 18429.525637948933, 18491.44525664205, 6569.540132190797, 7810.843783124305, 7934.166912474223, 7969.645160322759, 8027.397945154137, 803.6624617660597, 842.5113434208145, 911.2345629671108, 969.4377261188494, 991.2218908157062, 24403.63394549083, 29686.55470167949, 29802.254943626584, 29859.552106718416, 30155.0, 926.9675561355455, 1044.8611013994782, 1104.2877344113, 1108.38484641025, 1136.465861045324, 12236.694082648006, 15112.622184445258, 15288.923555382375, 15470.226488675522, 15648.4523041693, 642415.0, 647469.0, 648056.7597161984, 648075.0, 648144.0, 53867.73066134644, 53949.73025134849, 54251.72874135604, 54499.18251226235, 54562.72718636461, 1315.7302752935625, 1337.7458282926214, 1367.8905687544973, 1369.3221855181748, 1392.394308475796, 28371.290717732223, 28535.571966420935, 29103.7089629101, 29312.853435732686, 29313.267168320108, 39693.404598930465, 48243.5175648239, 49063.0, 49132.26301605407, 49242.0, 543454.0, 575131.0, 576124.0, 578643.0, 579240.1037994783, 21419.0, 21455.0, 21749.34751957444, 21756.45608859728, 26365.868170659025, 43373.34939975966, 45107.323390148515, 45572.08855822931, 46153.76923115363, 46259.0, 37346.11352403818, 37643.623563765104, 37838.0, 38678.6132138675, 39317.213655726155, 34411.13972150716, 37789.81105094567, 38290.42564361481, 38586.614133859424, 39064.0, 30975.0707478776, 34610.0, 36933.0, 37480.06299842526, 39360.80319598383, 25859.741402585732, 32412.351752964336, 33235.50146747752, 34654.82672586621, 34765.0, 21386.679199812326, 25384.857681404752, 25951.091711789995, 25960.350991225372, 26374.736252637995], "value": 19245.693565571797, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.95563643271726, 363.4366731566072, 372.10323121277725, 375.46871177284146, 397.6778809164577, 18446.26214951402, 18457.723134153, 18566.443006709786, 18609.90695046523, 18940.24239030439, 16423.83576164241, 19326.420207393767, 19531.316403925866, 19905.800941990576, 20288.49278768028, 5805.448482394177, 6035.034394496882, 6051.1830902828215, 6056.818295451121, 6068.453839154476, 5625.268715067056, 5896.321922978869, 5921.674307913063, 5947.6134051286745, 5955.0, 5594.720263986805, 5842.795502157425, 5874.73563689635, 5883.117532370136, 5890.793822216223, 5673.347565030012, 5782.190493330937, 5791.507721843648, 5796.275465566804, 5811.302643682743, 4983.053219888209, 5004.124278251292, 5023.422306434771, 5026.5727413169925, 5034.0686972910125, 20863.165473381046, 23002.654960175612, 24398.512029759484, 24565.38586535333, 24686.259412217663, 2381.6189409694366, 2415.516896620683, 2801.719828017182, 3048.6798886116862, 3054.3585846972164, 14963.326650300764, 15050.623734406618, 15106.697866042727, 15131.621709457242, 15769.29038193284, 1785.4911350265113, 1830.3776715916651, 1859.7489338939206, 1871.23279455424, 1876.502726777405, 116765.0, 117351.0, 120705.0, 122291.0, 123247.0, 10581.947090264499, 10756.462176891124, 11159.27464714791, 11421.955065037577, 11623.825642615368, 13822.101563398346, 13952.232627205602, 13954.0, 13954.23251721165, 13961.0, 7398.852022959511, 8297.875531867026, 8489.533075680773, 8630.870536941951, 8694.869576956224, 6869.7595584155315, 7220.819479512949, 8555.529445880411, 8773.341999350074, 9191.494467804336, 5774.931637647049, 6665.233498147678, 6715.160604924385, 6761.357671021246, 6807.353301436356, 1544.8104959181367, 1729.7751292331916, 1801.8108098649716, 1805.1966874740615, 1811.7644706188112, 708.2492557888654, 860.6858496648678, 877.8463768840427, 947.4126041854095, 1007.1690855044618, 20314.593708125754, 21045.579088418144, 21801.345959621238, 21831.126754929624, 21997.67003494949, 831.5925196653596, 887.0242732993655, 918.8070505193984, 949.6960972488737, 992.667456402099, 10949.671509854717, 11602.0, 11728.354940478184, 11744.882551174378, 11747.706307342385, 574496.0, 580986.0, 588609.0, 591269.2029075944, 591311.0, 117758.41120794341, 120696.0, 123529.0, 125057.74942250643, 135637.3218133903, 419.7607363802603, 446.3995925480224, 447.13925693040767, 447.2486223145082, 448.2894612039888, 11084.778304433705, 11113.888611138822, 11148.777024459627, 11177.832332514856, 11397.259178153394, 52268.73865630647, 52607.73696131495, 52902.0, 54224.0, 56867.431325686215, 54993.72503137459, 67846.66076669584, 70122.29877701362, 76071.61964190366, 78311.0, 8005.879911801211, 8126.55303958288, 8225.629846657035, 8365.414420990472, 8532.445391049561, 8522.659093636184, 11230.3261804292, 11548.94225528867, 12906.483740650268, 12932.159409638343, 10985.725356865823, 11034.779304413707, 11330.263532870336, 11352.602658906899, 11352.772944541228, 10199.13307368882, 10538.683839484827, 10896.673099807018, 11049.5027723751, 11143.052840508648, 9825.705228843146, 11502.079833613458, 11523.135764817505, 11612.76774464489, 11653.067754579444, 7731.806704832424, 7900.68397264126, 8173.509589424653, 8266.958665206635, 8267.751967440987, 7965.641546130322, 10795.29830561011, 10856.402897840695, 11107.944745249188, 11223.102151827998], "value": 9234.997260910295, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.681949971006, 1468.3392473386975, 1656.7929008873891, 1749.7462867884149, 1814.41031664709, 5945.524358051356, 7134.821629459253, 8002.639881205345, 8458.238758511732, 8476.788080297996, 8019.959900200505, 8306.75079747607, 8327.250547450729, 8391.580420978942, 8399.580020998956, 1920.6350793349218, 2231.386368748591, 2274.0903638544632, 2278.1912421090524, 2279.5782780185637, 2311.838171328008, 2342.4495243617735, 2352.9529409411803, 2356.964645530318, 2363.2201373546773, 2282.224043825099, 2300.3903965449167, 2320.2575175943703, 2323.6398358254496, 2331.8134549236106, 1702.6509565539159, 1864.3567969050655, 2284.794368506834, 2315.6642286868396, 2317.2121478697322, 1749.4401791426749, 2098.646373089349, 2227.643577027684, 2337.6960995070704, 2351.6002279612508, 8328.583570821434, 8342.541160236184, 8377.874331885027, 8423.0, 8428.241458268723, 3881.6894648428342, 5217.113090774577, 5224.973875130638, 5229.346331708536, 5286.154215325568, 2974.6876577959433, 3220.339830334776, 3297.258116923697, 3370.4775759757276, 3417.9829100854586, 993.7565296502331, 1023.6059117239841, 1028.2442404832443, 1034.095166729112, 1041.536516250269, 10873.401962892038, 10985.450727463594, 10987.890121098846, 10998.890011099867, 11019.669409917715, 4577.610903073276, 4752.572268495852, 4771.832985845479, 4787.090452814024, 4793.736344501016, 8340.582970851434, 8653.610587523577, 8684.913150868537, 8750.781230469289, 8759.605817738217, 5077.543021128116, 5106.336176297132, 5130.820421285312, 5130.948690513122, 5133.358330208724, 4583.0, 4667.416572928384, 4739.810407583727, 4743.478217396084, 4778.187708089564, 3634.945475817865, 3681.0, 3724.9627503724614, 3746.28820524105, 3780.281746468162, 1156.8958793708607, 1158.530795028015, 1167.0605162843822, 1170.3212136960542, 1174.8413964114907, 638.9073584330339, 810.9026916770025, 819.6311659753135, 826.1325608111459, 879.2702057292432, 5413.404525502192, 5554.666719996813, 5622.409646987089, 5705.486506214377, 5758.107493338539, 433.7701018460221, 447.95296493868324, 451.69059194451904, 455.4921262792029, 456.78302806166806, 3749.343864823645, 3753.211825516672, 3850.2492014057552, 3854.71089668276, 3881.9611803882162, 9787.510624468749, 10251.436171010517, 10282.948585257025, 10303.3817970922, 10334.741631459274, 10205.846912296322, 10235.948820255851, 10260.230482713827, 10264.486775661187, 10286.2799604027, 7618.923810761932, 7714.344280736088, 7733.729319473791, 7954.960225198953, 7957.045154581603, 5195.272661827272, 5495.862603434946, 5542.7782888684005, 5695.971520142372, 5708.65748055118, 9079.547272436379, 9120.087991200828, 9157.221636161, 9219.953900230455, 9402.905970940477, 8642.524661143698, 9043.728688139367, 9449.527523623929, 9635.277354198322, 9672.274579406714, 6979.232284448808, 7227.349538541346, 7233.746818861315, 7236.0, 7249.347558719741, 7635.847283054197, 7847.646855891613, 7889.447738658469, 7991.200879912195, 8010.118886922317, 7126.821829454305, 7210.783676489714, 7225.674844631899, 7243.601601911945, 7298.306660867209, 6322.905156422566, 7051.224365319913, 7103.893441598483, 7125.0, 7132.358087772125, 6688.899666505104, 6700.765473208415, 6721.428678562377, 6739.764108256188, 6740.831479212863, 4807.735574543433, 4823.758812059313, 4852.975735121302, 4861.0, 4918.065567542156, 4771.71369717818, 4853.878653033561, 4856.63575231852, 4897.142999975062, 5007.974960125176], "value": 4265.396595781025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.27455439520435, 296.7670378752678, 299.0072957780168, 299.80812280140714, 309.34419031652897, 4249.936250956238, 4610.262358022717, 4760.785764640591, 4988.925166122506, 5384.246205531219, 5201.973990130044, 5343.305370301865, 5353.304070470843, 5370.3287089113865, 5374.758135883885, 3777.3956167013284, 4126.773027483495, 4168.312228482312, 4190.2248084104385, 4193.238839687323, 3784.5807822066727, 4038.6567141792984, 4148.502179738435, 4159.438475805758, 4183.937240941388, 3338.5492958450664, 4043.2115737431213, 4045.858394956177, 4053.5338436079933, 4078.1232035112444, 3715.2198038411966, 3719.274741425423, 4065.79671016448, 4074.22589707956, 4092.1611069730634, 3272.443684573628, 3528.6767462201674, 3532.788032718045, 3542.2384187399834, 3549.94675079874, 4731.881702957454, 4934.950650493485, 5114.744262786883, 5147.6911385317, 5224.791008359661, 3951.288768021755, 4307.569243075699, 4583.427071616048, 4609.308603709437, 4627.120847039052, 4857.392825896763, 5294.96748134114, 5618.831435056954, 5629.437056294379, 5649.971750141223, 3706.9426468310076, 3831.961680383188, 3860.942085868714, 3865.3042452358563, 3873.973397049784, 4730.763461826895, 4746.1931471649905, 5080.348886611866, 5669.404712505168, 5902.822915312548, 3616.7214654767326, 3865.8840234793, 3908.7459315144424, 3957.3074711925874, 3991.44119823225, 3798.3163030654196, 3938.448617193595, 3947.013246688328, 3961.267165574378, 3989.8204580793936, 3624.3657359961903, 4209.536950935395, 4552.453705555355, 4561.635069194456, 4569.725816451024, 4960.826371076995, 5333.839984800462, 5707.200991861143, 5737.41007194243, 5750.6262092963825, 1101.5043230546287, 1211.4185191108318, 1239.2936026465009, 1243.9564615238605, 1266.5060626355728, 759.9582022988789, 779.8713212320017, 867.3754896474528, 868.5136323658771, 869.7260362985639, 4473.664475164311, 4535.63714902807, 4622.602387245372, 4767.976160119178, 4834.7824347904425, 5193.896122077613, 5368.892622147535, 5538.44615538451, 5581.274434323512, 5588.860278492989, 4731.526847315241, 4789.449213340441, 4854.83008094722, 5069.746512674352, 5132.589392848563, 2418.600930846391, 2566.242958327298, 2669.8398096114297, 2910.57796619489, 2952.4242772659127, 5442.8911421771345, 5754.4533269339345, 5757.222774925415, 5790.652560846363, 5866.386743645532, 5325.4142044375085, 5466.617336786387, 5708.915306091829, 5755.65466072037, 5771.307443106854, 5292.52367286946, 5604.187392828017, 5638.689872057076, 5781.971090144522, 5805.880853488531, 4349.739015659071, 5254.5533629641905, 5375.731213439234, 5625.774969001194, 5637.956977959091, 4997.503744383424, 5271.393789714232, 5498.917516237179, 5547.55619550443, 5563.248961390323, 5225.1189571753375, 5561.138023606348, 5663.329317851326, 5797.362290148165, 5837.8540536485225, 3316.6517515660507, 3714.145746478271, 3736.4208547675153, 3744.9063773405883, 3753.887383378503, 5104.387473503203, 5152.377001244596, 5236.581073514034, 5479.753411096431, 5495.323926202387, 5218.746721422029, 5487.917681234864, 5541.944580554143, 5611.551075913835, 5689.212285979923, 5456.672599644034, 5745.075399741134, 5756.683382414008, 5815.975692639889, 5845.41545845412, 4471.069841745347, 5061.772220250024, 5309.637211440871, 5391.433899440659, 5700.600957932905, 4343.587359200871, 4590.265557510782, 5492.47821456961, 5771.480566749013, 5778.248827652546, 5243.528082472596, 5596.580256480699, 5633.690147041788, 5645.137104755503, 5672.688002159921], "value": 4010.724113586253, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.9598326108803, 640.6540468147201, 685.7930043124103, 698.2040473859797, 757.1746795992369, 12642.367881605905, 13906.0, 14414.270287565507, 14816.703665926674, 14865.479708210214, 10627.41549214793, 11696.473658685358, 12936.029797765183, 12939.0, 12950.35248237589, 642.4828013449171, 667.0694381338055, 803.4536515169697, 817.599376305609, 820.7086484298048, 775.7207405334075, 809.6882700160451, 812.3095368936416, 818.5129847740615, 821.8726097454904, 837.3552364679193, 837.6523742646795, 838.5220424358088, 839.7690635075342, 840.3949156607233, 833.3624777045565, 833.5873742497472, 835.4527784301262, 836.6318819719335, 846.4159729786489, 564.3199944067389, 604.5103466192398, 626.9811905642838, 629.1412222316505, 629.2574761781096, 13798.310084495835, 13856.030077894551, 13866.653333666638, 13869.791953120712, 13873.306334683226, 10972.0, 13046.608601741962, 13522.594322170351, 13589.252591107484, 13652.453901843914, 10962.287451315638, 11064.336139831556, 11195.60815371458, 11431.199816012882, 11567.363794991355, 3556.733245006609, 3652.196516766334, 3708.332500149972, 3758.906027349311, 3770.019794853358, 59125.7043714783, 61732.0, 69398.9590156148, 71130.0, 75493.62253188754, 8797.516136612549, 9172.495512746864, 9733.805323893483, 10467.110295624805, 10558.260921735558, 14961.850381496046, 19590.21639134447, 20158.89920550388, 20207.898960505398, 20248.89875550613, 7125.89311160333, 7664.233576642403, 7679.808004799925, 7798.1811909749795, 7857.371410287164, 4204.348326009474, 4268.0, 4311.310190369526, 4375.0, 4417.293233082692, 2916.7958242923214, 3005.7294843463756, 3379.4086034943784, 3404.0, 3448.2930999145115, 621.5959626242887, 621.6984762390238, 624.3506752976944, 636.0554576453962, 636.239693566184, 572.4761842913771, 627.4541149200134, 653.3401264722664, 659.2128223356846, 677.3260605697362, 8830.823383532294, 8945.15021072997, 9022.909770902339, 9118.088191180961, 9621.27840411972, 639.4916041746823, 641.6118248459708, 651.7327895562796, 667.0827612033454, 669.2303850571881, 4328.567143285646, 4333.653307735373, 4469.524383982296, 4476.462824461086, 4506.842260520932, 99027.50486247666, 116583.41708291574, 118519.0, 119309.0, 121898.39050804867, 81064.59467702742, 104817.33139340239, 105169.0, 105923.0, 110852.0, 92172.53913730389, 93578.59632105524, 94816.0, 95197.5240123795, 95265.0, 7939.523628582304, 8719.171678690767, 8797.340199484936, 8896.911030889609, 9026.465500864737, 59792.10311845413, 60205.69897150486, 60218.69890650519, 60370.698146510746, 62684.059739104865, 79335.60332198303, 83474.0, 84241.57879210565, 84258.57870710608, 86539.0, 12196.939015304866, 12214.529604429188, 12263.141580089308, 12328.32194229326, 12559.560415385418, 11807.350595717318, 14084.577462676136, 14324.0, 14521.34653940554, 14589.562313130624, 12583.370831458573, 12594.496220151092, 12812.743745125232, 13139.277339746406, 13309.267990260241, 12687.302198379179, 12975.156614820007, 13213.546509884098, 13438.865611343761, 13653.996884642826, 12705.745885082062, 12932.93533532364, 13168.473261069834, 13212.603621891358, 13795.241261730702, 10460.21548383859, 10680.092192163753, 11443.656690299304, 11559.30644161353, 11614.593489227836, 11229.0, 11324.716882077684, 11425.828612570984, 11610.477528511406, 11658.00906922887], "value": 7207.933052404508, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1583.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 162.0, 124.0, 168.0, 173.0, 151.0, 125.0, 107.0, 99.0, 155.0], "value": 141.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 106.0, 138.0, 142.0, 145.0, 144.0, 137.0, 113.0, 140.0, 112.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 200.0, 203.0, 199.0, 198.0, 197.0, 202.0, 197.0, 276.0], "value": 207.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 60.0, 89.0, 60.0, 62.0, 59.0, 60.0, 83.0, 58.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 58.0, 116.0, 95.0, 102.0, 101.0, 127.0, 55.0, 103.0, 124.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 105.0, 87.0, 90.0, 87.0, 97.0, 129.0, 96.0, 87.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 117.0, 131.0, 102.0, 101.0, 105.0, 100.0, 100.0, 102.0, 103.0], "value": 106.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 87.0, 89.0, 87.0, 90.0, 88.0, 89.0, 99.0, 90.0, 87.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 62.0, 62.0, 62.0, 62.0, 61.0, 61.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 79.0, 83.0, 78.0, 74.0, 68.0, 83.0, 61.0, 74.0, 62.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 83.0, 74.0, 108.0, 104.0, 79.0, 92.0, 106.0, 105.0], "value": 92.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 153.0, 141.0, 141.0, 145.0, 143.0, 144.0, 146.0, 215.0, 181.0], "value": 156.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 169.0, 151.0, 229.0, 232.0, 192.0, 168.0, 173.0, 170.0, 198.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 65.0, 88.0, 89.0, 88.0, 67.0, 69.0, 69.0, 69.0], "value": 73.9, "unit": "score"}]}]} 03:43:45 INFO - Return code: 0 03:43:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:43:45 ERROR - # TBPL SUCCESS # 03:43:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:43:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:43:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:43:45 INFO - 2017-01-05 03:43:45.724 screenresolution[2256:31713] starting screenresolution argv=screenresolution get 03:43:45 INFO - 2017-01-05 03:43:45.729 screenresolution[2256:31713] Display 0: 1600x1200x32@60 03:43:45 INFO - 2017-01-05 03:43:45.735 screenresolution[2257:31716] starting screenresolution argv=screenresolution list 03:43:45 INFO - Available Modes on Display 0 03:43:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:43:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:43:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:43:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:43:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:43:45 INFO - Intel Iris: 03:43:45 INFO - Chipset Model: Intel Iris 03:43:45 INFO - Type: GPU 03:43:45 INFO - Bus: Built-In 03:43:45 INFO - VRAM (Dynamic, Max): 1536 MB 03:43:45 INFO - Vendor: Intel (0x8086) 03:43:45 INFO - Device ID: 0x0a2e 03:43:45 INFO - Revision ID: 0x0009 03:43:45 INFO - Displays: 03:43:45 INFO - Display: 03:43:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:43:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:43:45 INFO - Display Serial Number: 1600x1200 60 03:43:45 INFO - Main Display: Yes 03:43:45 INFO - Mirror: Off 03:43:45 INFO - Online: Yes 03:43:45 INFO - Rotation: Supported 03:43:45 INFO - Return code: 0 03:43:45 INFO - Running post-action listener: _resource_record_post_action 03:43:45 INFO - [mozharness: 2017-01-05 11:43:45.984420Z] Finished run-tests step (success) 03:43:45 INFO - Running post-run listener: _resource_record_post_run 03:43:46 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 348160; Write bytes: 661477888; Read time: 5; Write time: 1998 03:43:46 INFO - TinderboxPrint: CPU usage
54.4% 03:43:46 INFO - TinderboxPrint: I/O read bytes / time
348,160 / 5 03:43:46 INFO - TinderboxPrint: I/O write bytes / time
661,477,888 / 1,998 03:43:46 INFO - TinderboxPrint: CPU idle
2,210.4 (45.6%) 03:43:46 INFO - TinderboxPrint: CPU system
978.8 (20.2%) 03:43:46 INFO - TinderboxPrint: CPU user
1,656.6 (34.2%) 03:43:46 INFO - TinderboxPrint: Swap in / out
348,696,576 / 0 03:43:46 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 338516480; Write bytes: 333608448; Read time: 26763; Write time: 716 03:43:46 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 348160; Write bytes: 310109184; Read time: 5; Write time: 1224 03:43:46 INFO - Running post-run listener: _upload_blobber_files 03:43:46 INFO - Blob upload gear active. 03:43:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:43:46 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 03:43:46 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'] 03:43:46 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 03:43:46 INFO - (blobuploader) - INFO - Open directory for files ... 03:43:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:43:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:43:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:47 INFO - (blobuploader) - INFO - Done attempting. 03:43:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:43:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:43:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:48 INFO - (blobuploader) - INFO - Done attempting. 03:43:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:43:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:43:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:43:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:43:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:43:51 INFO - (blobuploader) - INFO - Done attempting. 03:43:51 INFO - (blobuploader) - INFO - Iteration through files over. 03:43:51 INFO - Return code: 0 03:43:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:43:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:43:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbe9200a13996999e7471b6552c47129352ec384feaa19aaa37bba5cb13e06819670a2ba7992f60f13c4424906a693f01a440495478322ab1b822711c31f1714", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5cc44bcf5602a419df69973be7906812fd985f35f82d90aeb9e2317a644babb0e0d252ff7179d4afd571b80716306bc8bac7a90bf3d1cfb1a63aa2b1c4dc623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334f8b713b5cb85232cb988647fe526a5b5ce26625af17f957aab7c94cd62e6bcd2e1bb8f39bcf8c7772fb47d22926bfc079177da32a8cb562f528de4617e60d"} 03:43:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:43:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:43:51 INFO - Contents: 03:43:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cbe9200a13996999e7471b6552c47129352ec384feaa19aaa37bba5cb13e06819670a2ba7992f60f13c4424906a693f01a440495478322ab1b822711c31f1714", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5cc44bcf5602a419df69973be7906812fd985f35f82d90aeb9e2317a644babb0e0d252ff7179d4afd571b80716306bc8bac7a90bf3d1cfb1a63aa2b1c4dc623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334f8b713b5cb85232cb988647fe526a5b5ce26625af17f957aab7c94cd62e6bcd2e1bb8f39bcf8c7772fb47d22926bfc079177da32a8cb562f528de4617e60d"} 03:43:51 INFO - Running post-run listener: copy_logs_to_upload_dir 03:43:51 INFO - Copying logs to upload dir... 03:43:51 INFO - mkdir: /builds/slave/test/build/upload/logs 03:43:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.156926 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2017-01-05 03:43:51.881690) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:43:51.885286) ========= 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.7DXaHj0p52/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.EMVX5wfgzN/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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/cbe9200a13996999e7471b6552c47129352ec384feaa19aaa37bba5cb13e06819670a2ba7992f60f13c4424906a693f01a440495478322ab1b822711c31f1714", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5cc44bcf5602a419df69973be7906812fd985f35f82d90aeb9e2317a644babb0e0d252ff7179d4afd571b80716306bc8bac7a90bf3d1cfb1a63aa2b1c4dc623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334f8b713b5cb85232cb988647fe526a5b5ce26625af17f957aab7c94cd62e6bcd2e1bb8f39bcf8c7772fb47d22926bfc079177da32a8cb562f528de4617e60d"} build_url:https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011467 build_url: 'https://queue.taskcluster.net/v1/task/FXsqIadMTOGZbW5AaQC2iA/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/cbe9200a13996999e7471b6552c47129352ec384feaa19aaa37bba5cb13e06819670a2ba7992f60f13c4424906a693f01a440495478322ab1b822711c31f1714", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c5cc44bcf5602a419df69973be7906812fd985f35f82d90aeb9e2317a644babb0e0d252ff7179d4afd571b80716306bc8bac7a90bf3d1cfb1a63aa2b1c4dc623", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/334f8b713b5cb85232cb988647fe526a5b5ce26625af17f957aab7c94cd62e6bcd2e1bb8f39bcf8c7772fb47d22926bfc079177da32a8cb562f528de4617e60d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-05 03:43:51.925187) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:43:51.925523) ========= 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.7DXaHj0p52/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.EMVX5wfgzN/Listeners TMPDIR=/var/folders/yk/gx088sh5025_4j2qsy7fj5kw00000w/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.005209 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-05 03:43:51.975108) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:43:51.975421) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-05 03:43:51.975821) ========= ========= Total master_lag: 0.60 =========