builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0090 starttime: 1488242796.09 results: success (0) buildid: 20170227142922 builduid: 217dd2ef11b541ec945bb1ffc5cd4b96 revision: caca7170b92ee7874322eba772c15c9416a5ef5d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.090064) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.090565) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.090833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.125934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.126186) ========= 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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-02-27 16:46:36-- 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% 15.0M=0.001s 2017-02-27 16:46:36 (15.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.463868 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.613961) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.614231) ========= 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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.025987 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:36.664726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 16:46:36.665024) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev caca7170b92ee7874322eba772c15c9416a5ef5d --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-beta --rev caca7170b92ee7874322eba772c15c9416a5ef5d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TG5j0zLRGo/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.gR3eWbuw3V/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-02-27 16:46:36,799 truncating revision to first 12 chars 2017-02-27 16:46:36,799 Setting DEBUG logging. 2017-02-27 16:46:36,799 attempt 1/10 2017-02-27 16:46:36,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/caca7170b92e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 16:46:37,956 unpacking tar archive at: mozilla-beta-caca7170b92e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.419985 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 16:46:38.111252) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:38.111969) ========= script_repo_revision: caca7170b92ee7874322eba772c15c9416a5ef5d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:38.112893) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:38.113601) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 16:46:38.137739) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-27 16:46:38.138107) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.TG5j0zLRGo/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.gR3eWbuw3V/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:46:38 INFO - MultiFileLogger online at 20170227 16:46:38 in /builds/slave/test 16:46:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 16:46:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:38 INFO - {'append_to_log': False, 16:46:38 INFO - 'base_work_dir': '/builds/slave/test', 16:46:38 INFO - 'blob_upload_branch': 'Mozilla-Beta', 16:46:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:38 INFO - 'branch': 'Mozilla-Beta', 16:46:38 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:38 INFO - 'config_files': ('talos/mac_config.py',), 16:46:38 INFO - 'default_actions': ('clobber', 16:46:38 INFO - 'read-buildbot-config', 16:46:38 INFO - 'download-and-extract', 16:46:38 INFO - 'populate-webroot', 16:46:38 INFO - 'create-virtualenv', 16:46:38 INFO - 'install', 16:46:38 INFO - 'run-tests'), 16:46:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:38 INFO - 'download_minidump_stackwalk': True, 16:46:38 INFO - 'download_symbols': 'ondemand', 16:46:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:38 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:38 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:38 INFO - 'installer_path': 'installer.exe', 16:46:38 INFO - 'log_level': 'info', 16:46:38 INFO - 'log_name': 'talos', 16:46:38 INFO - 'log_to_console': True, 16:46:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:46:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:46:38 INFO - 'opt_config_files': (), 16:46:38 INFO - 'pip_index': False, 16:46:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:46:38 INFO - 'cmd': ('bash', 16:46:38 INFO - '-c', 16:46:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:46:38 INFO - 'enabled': True, 16:46:38 INFO - 'halt_on_failure': False, 16:46:38 INFO - 'name': 'check_screen_resolution'},), 16:46:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:46:38 INFO - 'cmd': ('bash', 16:46:38 INFO - '-c', 16:46:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:46:38 INFO - 'enabled': True, 16:46:38 INFO - 'halt_on_failure': False, 16:46:38 INFO - 'name': 'check_screen_resolution'},), 16:46:38 INFO - 'run_cmd_checks_enabled': True, 16:46:38 INFO - 'sps_profile': False, 16:46:38 INFO - 'sps_profile_interval': 0, 16:46:38 INFO - 'suite': 'dromaeojs-e10s', 16:46:38 INFO - 'system_bits': '32', 16:46:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:38 INFO - 'title': 't-yosemite-r7-0090', 16:46:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:38 INFO - 'use_talos_json': True, 16:46:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:38 INFO - 'work_dir': 'build'} 16:46:38 INFO - [mozharness: 2017-02-28 00:46:38.381897Z] Running clobber step. 16:46:38 INFO - Running pre-action listener: _resource_record_pre_action 16:46:38 INFO - Running main action method: clobber 16:46:38 INFO - rmtree: /builds/slave/test/build 16:46:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:40 INFO - Running post-action listener: _resource_record_post_action 16:46:40 INFO - [mozharness: 2017-02-28 00:46:40.776882Z] Finished clobber step (success) 16:46:40 INFO - [mozharness: 2017-02-28 00:46:40.777039Z] Running read-buildbot-config step. 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: read_buildbot_config 16:46:40 INFO - Using buildbot properties: 16:46:40 INFO - { 16:46:40 INFO - "project": "", 16:46:40 INFO - "product": "firefox", 16:46:40 INFO - "script_repo_revision": "production", 16:46:40 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 16:46:40 INFO - "repository": "", 16:46:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 16:46:40 INFO - "buildid": "20170227142922", 16:46:40 INFO - "pgo_build": "False", 16:46:40 INFO - "basedir": "/builds/slave/test", 16:46:40 INFO - "buildnumber": 21, 16:46:40 INFO - "slavename": "t-yosemite-r7-0090", 16:46:40 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:46:40 INFO - "platform": "yosemite_r7", 16:46:40 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 16:46:40 INFO - "branch": "mozilla-beta", 16:46:40 INFO - "repo_path": "releases/mozilla-beta", 16:46:40 INFO - "revision": "caca7170b92ee7874322eba772c15c9416a5ef5d", 16:46:40 INFO - "stage_platform": "macosx64", 16:46:40 INFO - "builduid": "217dd2ef11b541ec945bb1ffc5cd4b96", 16:46:40 INFO - "slavebuilddir": "test" 16:46:40 INFO - } 16:46:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 16:46:40 INFO - Running post-action listener: _resource_record_post_action 16:46:40 INFO - [mozharness: 2017-02-28 00:46:40.780391Z] Finished read-buildbot-config step (success) 16:46:40 INFO - [mozharness: 2017-02-28 00:46:40.780558Z] Running download-and-extract step. 16:46:40 INFO - Running pre-action listener: _resource_record_pre_action 16:46:40 INFO - Running main action method: download_and_extract 16:46:40 INFO - mkdir: /builds/slave/test/build/tests 16:46:40 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')]} 16:46:40 INFO - trying https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 16:46:40 INFO - Downloading https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 16:46:41 INFO - Downloaded 1165 bytes. 16:46:41 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 16:46:41 INFO - Using the following test package requirements: 16:46:41 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:46:41 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 16:46:41 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 16:46:41 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 16:46:41 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 16:46:41 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 16:46:41 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 16:46:41 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 16:46:41 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 16:46:41 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 16:46:41 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 16:46:41 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 16:46:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:46:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:46:41 INFO - Fetch https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:46:42 INFO - Http code: 200 16:46:42 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 16:46:42 INFO - x-amz-cf-id: WgOFYIQEZBh0guNEbycKk1kpAQWw9AGc7jpYkijS9aDn3PGn5m9KwA== 16:46:42 INFO - x-amz-version-id: sizHDKWOEatPXBNVz6etX2Wy.VYK3Tur 16:46:42 INFO - Expected file size: 16093394 16:46:42 INFO - Obtained file size: 16093394 16:46:49 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 16:46:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 16:46:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 16:46:49 INFO - Fetch https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 16:46:49 INFO - Http code: 200 16:46:49 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 16:46:49 INFO - x-amz-cf-id: 6-lxdCafekHMBvBnST5M5hlFH5DrAmTRXagdZu5Vv4B8eGXydXuxFw== 16:46:49 INFO - x-amz-version-id: sizHDKWOEatPXBNVz6etX2Wy.VYK3Tur 16:46:50 INFO - Expected file size: 16093394 16:46:50 INFO - Obtained file size: 16093394 16:46:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 16:46:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 16:46:56 INFO - Fetch https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 16:46:57 INFO - Http code: 200 16:46:57 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 16:46:57 INFO - x-amz-cf-id: n3olu2ckgIm8lkyTY70ow5oI2XtdO4mCLyYuioSCZy8nsCeAgp-hbQ== 16:46:57 INFO - x-amz-version-id: R4BsJzcx8Az6CzT2EBYNCkPLcoMKVt_O 16:46:57 INFO - Expected file size: 14402992 16:46:57 INFO - Obtained file size: 14402992 16:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:58 INFO - trying https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:46:58 INFO - Downloading https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 16:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 16:47:00 INFO - Downloaded 82112335 bytes. 16:47:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:47:00 INFO - mkdir: /builds/slave/test/properties 16:47:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:47:00 INFO - Writing to file /builds/slave/test/properties/build_url 16:47:00 INFO - Contents: 16:47:00 INFO - build_url:https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg 16:47:01 INFO - Running post-action listener: _resource_record_post_action 16:47:01 INFO - Running post-action listener: set_extra_try_arguments 16:47:01 INFO - [mozharness: 2017-02-28 00:47:01.432665Z] Finished download-and-extract step (success) 16:47:01 INFO - [mozharness: 2017-02-28 00:47:01.432797Z] Running populate-webroot step. 16:47:01 INFO - Running pre-action listener: _resource_record_pre_action 16:47:01 INFO - Running main action method: populate_webroot 16:47:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:47:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:47:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:47:01 INFO - '--tppagecycles', 16:47:01 INFO - '7'], 16:47:01 INFO - 'tests': ['tsvgm']}}, 16:47:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:47:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:47:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:47:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:47:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:47:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['damp', 'tps']}, 16:47:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'tests': ['damp', 'tps']}, 16:47:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['dromaeo_dom']}, 16:47:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:47:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['basic_compositor_video']}, 16:47:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:47:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['a11yr', 16:47:01 INFO - 'ts_paint', 16:47:01 INFO - 'tpaint', 16:47:01 INFO - 'sessionrestore', 16:47:01 INFO - 'sessionrestore_no_auto_restore', 16:47:01 INFO - 'tabpaint']}, 16:47:01 INFO - 'other-e10s': {'tests': ['a11yr', 16:47:01 INFO - 'ts_paint', 16:47:01 INFO - 'tpaint', 16:47:01 INFO - 'sessionrestore', 16:47:01 INFO - 'sessionrestore_no_auto_restore', 16:47:01 INFO - 'tabpaint']}, 16:47:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:47:01 INFO - 'ts_paint', 16:47:01 INFO - 'tpaint', 16:47:01 INFO - 'sessionrestore', 16:47:01 INFO - 'sessionrestore_no_auto_restore', 16:47:01 INFO - 'tabpaint']}, 16:47:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:47:01 INFO - 'ts_paint', 16:47:01 INFO - 'tpaint', 16:47:01 INFO - 'sessionrestore', 16:47:01 INFO - 'sessionrestore_no_auto_restore', 16:47:01 INFO - 'tabpaint']}, 16:47:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['a11yr', 16:47:01 INFO - 'ts_paint', 16:47:01 INFO - 'tpaint', 16:47:01 INFO - 'sessionrestore', 16:47:01 INFO - 'sessionrestore_no_auto_restore', 16:47:01 INFO - 'tabpaint']}, 16:47:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['a11yr', 16:47:01 INFO - 'ts_paint', 16:47:01 INFO - 'tpaint', 16:47:01 INFO - 'sessionrestore', 16:47:01 INFO - 'sessionrestore_no_auto_restore', 16:47:01 INFO - 'tabpaint']}, 16:47:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['tsvgx', 16:47:01 INFO - 'tsvgr_opacity', 16:47:01 INFO - 'tart', 16:47:01 INFO - 'tscrollx', 16:47:01 INFO - 'cart']}, 16:47:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:47:01 INFO - 'tsvgr_opacity', 16:47:01 INFO - 'tart', 16:47:01 INFO - 'tscrollx', 16:47:01 INFO - 'cart']}, 16:47:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'talos_options': ['--disable-e10s'], 16:47:01 INFO - 'tests': ['tp5o']}, 16:47:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'tests': ['tp5o']}, 16:47:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'talos_options': ['--disable-e10s', 16:47:01 INFO - '--xperf_path', 16:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:01 INFO - 'tests': ['tp5n']}, 16:47:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:47:01 INFO - 'talos_options': ['--xperf_path', 16:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:47:01 INFO - 'tests': ['tp5n']}}, 16:47:01 INFO - 'talos.zip': {'path': '', 16:47:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:47:01 INFO - Running post-action listener: _resource_record_post_action 16:47:01 INFO - [mozharness: 2017-02-28 00:47:01.451792Z] Finished populate-webroot step (success) 16:47:01 INFO - [mozharness: 2017-02-28 00:47:01.451923Z] Running create-virtualenv step. 16:47:01 INFO - Running pre-action listener: _resource_record_pre_action 16:47:01 INFO - Running main action method: create_virtualenv 16:47:01 INFO - Creating virtualenv /builds/slave/test/build/venv 16:47: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 16:47:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:47:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:47:01 INFO - Using real prefix '/tools/python27' 16:47:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:47:02 INFO - Installing distribute.............................................................................................................................................................................................done. 16:47:05 INFO - Installing pip.................done. 16:47:05 INFO - Return code: 0 16:47:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:47:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:47:05 INFO - Reading from file tmpfile_stdout 16:47:05 INFO - Output received: 16:47: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) 16:47:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:05 INFO - 'HOME': '/Users/cltbld', 16:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:05 INFO - 'LOGNAME': 'cltbld', 16:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:05 INFO - 'MOZ_NO_REMOTE': '1', 16:47:05 INFO - 'NO_EM_RESTART': '1', 16:47:05 INFO - 'PAGER': '/bin/cat', 16:47:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:05 INFO - 'PWD': '/builds/slave/test', 16:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:05 INFO - 'SHELL': '/bin/bash', 16:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:05 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:05 INFO - 'USER': 'cltbld', 16:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:05 INFO - 'XPC_FLAGS': '0x0', 16:47:05 INFO - 'XPC_SERVICE_NAME': '0', 16:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47: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 16:47:05 INFO - Cleaning up... 16:47:05 INFO - Return code: 0 16:47:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:05 INFO - 'HOME': '/Users/cltbld', 16:47:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:05 INFO - 'LOGNAME': 'cltbld', 16:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:05 INFO - 'MOZ_NO_REMOTE': '1', 16:47:05 INFO - 'NO_EM_RESTART': '1', 16:47:05 INFO - 'PAGER': '/bin/cat', 16:47:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:05 INFO - 'PWD': '/builds/slave/test', 16:47:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:05 INFO - 'SHELL': '/bin/bash', 16:47:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:05 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:05 INFO - 'USER': 'cltbld', 16:47:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:05 INFO - 'XPC_FLAGS': '0x0', 16:47:05 INFO - 'XPC_SERVICE_NAME': '0', 16:47:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:05 INFO - Downloading/unpacking psutil>=3.1.1 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:09 INFO - Installing collected packages: psutil 16:47:09 INFO - Running setup.py install for psutil 16:47:09 INFO - building 'psutil._psutil_osx' extension 16:47: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 16:47:10 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 16:47:10 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 16:47:10 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 16:47:10 INFO - building 'psutil._psutil_posix' extension 16:47:10 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 16:47:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:47:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:47:10 INFO - ^ 16:47:10 INFO - 1 warning generated. 16:47: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 16:47:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:10 INFO - Successfully installed psutil 16:47:10 INFO - Cleaning up... 16:47:10 INFO - Return code: 0 16:47:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:10 INFO - 'HOME': '/Users/cltbld', 16:47:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:10 INFO - 'LOGNAME': 'cltbld', 16:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:10 INFO - 'MOZ_NO_REMOTE': '1', 16:47:10 INFO - 'NO_EM_RESTART': '1', 16:47:10 INFO - 'PAGER': '/bin/cat', 16:47:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:10 INFO - 'PWD': '/builds/slave/test', 16:47:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:10 INFO - 'SHELL': '/bin/bash', 16:47:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:10 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:10 INFO - 'USER': 'cltbld', 16:47:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:10 INFO - 'XPC_FLAGS': '0x0', 16:47:10 INFO - 'XPC_SERVICE_NAME': '0', 16:47:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:47:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:47:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:47:13 INFO - Installing collected packages: mozsystemmonitor 16:47:13 INFO - Running setup.py install for mozsystemmonitor 16:47:14 INFO - Successfully installed mozsystemmonitor 16:47:14 INFO - Cleaning up... 16:47:14 INFO - Return code: 0 16:47:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:47:14 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')]} 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:14 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')]} 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:14 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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47:14 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 16:47:14 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 16:47:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:14 INFO - 'HOME': '/Users/cltbld', 16:47:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:14 INFO - 'LOGNAME': 'cltbld', 16:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:14 INFO - 'MOZ_NO_REMOTE': '1', 16:47:14 INFO - 'NO_EM_RESTART': '1', 16:47:14 INFO - 'PAGER': '/bin/cat', 16:47:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:14 INFO - 'PWD': '/builds/slave/test', 16:47:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:14 INFO - 'SHELL': '/bin/bash', 16:47:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:14 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:14 INFO - 'USER': 'cltbld', 16:47:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:14 INFO - 'XPC_FLAGS': '0x0', 16:47:14 INFO - 'XPC_SERVICE_NAME': '0', 16:47:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:14 INFO - Downloading/unpacking jsonschema==2.5.1 16:47:14 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 16:47:14 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 16:47:14 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 16:47:14 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 16:47:14 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 16:47:14 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 16:47:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:17 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:17 INFO - warning: no files found matching '*.txt' 16:47:17 INFO - no previously-included directories found matching 'build' 16:47:17 INFO - no previously-included directories found matching 'dist' 16:47:17 INFO - no previously-included directories found matching '.git*' 16:47:17 INFO - Installing collected packages: jsonschema, functools32 16:47:17 INFO - Running setup.py install for functools32 16:47:17 INFO - warning: no files found matching '*.txt' 16:47:17 INFO - no previously-included directories found matching 'build' 16:47:17 INFO - no previously-included directories found matching 'dist' 16:47:17 INFO - no previously-included directories found matching '.git*' 16:47:17 INFO - Successfully installed jsonschema functools32 16:47:17 INFO - Cleaning up... 16:47:17 INFO - Return code: 0 16:47:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:17 INFO - 'HOME': '/Users/cltbld', 16:47:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:17 INFO - 'LOGNAME': 'cltbld', 16:47:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:17 INFO - 'MOZ_NO_REMOTE': '1', 16:47:17 INFO - 'NO_EM_RESTART': '1', 16:47:17 INFO - 'PAGER': '/bin/cat', 16:47:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:17 INFO - 'PWD': '/builds/slave/test', 16:47:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:17 INFO - 'SHELL': '/bin/bash', 16:47:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:17 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:17 INFO - 'USER': 'cltbld', 16:47:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:17 INFO - 'XPC_FLAGS': '0x0', 16:47:17 INFO - 'XPC_SERVICE_NAME': '0', 16:47:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:47:18 INFO - Cleaning up... 16:47:18 INFO - Return code: 0 16:47:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:18 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')]} 16:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:18 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')]} 16:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:18 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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47:18 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 16:47:18 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 16:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:18 INFO - 'HOME': '/Users/cltbld', 16:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:18 INFO - 'LOGNAME': 'cltbld', 16:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:18 INFO - 'MOZ_NO_REMOTE': '1', 16:47:18 INFO - 'NO_EM_RESTART': '1', 16:47:18 INFO - 'PAGER': '/bin/cat', 16:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:18 INFO - 'PWD': '/builds/slave/test', 16:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:18 INFO - 'SHELL': '/bin/bash', 16:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:18 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:18 INFO - 'USER': 'cltbld', 16:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:18 INFO - 'XPC_FLAGS': '0x0', 16:47:18 INFO - 'XPC_SERVICE_NAME': '0', 16:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:18 INFO - Downloading/unpacking blobuploader==1.2.4 16:47:18 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 16:47:18 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 16:47:18 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 16:47:18 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 16:47:18 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 16:47:18 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 16:47:20 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:22 INFO - Downloading docopt-0.6.1.tar.gz 16:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:22 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:22 INFO - Running setup.py install for blobuploader 16:47:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:22 INFO - Running setup.py install for requests 16:47:22 INFO - Running setup.py install for docopt 16:47:23 INFO - Successfully installed blobuploader requests docopt 16:47:23 INFO - Cleaning up... 16:47:23 INFO - Return code: 0 16:47:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47:23 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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47:23 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 16:47:23 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 16:47:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:23 INFO - 'HOME': '/Users/cltbld', 16:47:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:23 INFO - 'LOGNAME': 'cltbld', 16:47:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:23 INFO - 'MOZ_NO_REMOTE': '1', 16:47:23 INFO - 'NO_EM_RESTART': '1', 16:47:23 INFO - 'PAGER': '/bin/cat', 16:47:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:23 INFO - 'PWD': '/builds/slave/test', 16:47:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:23 INFO - 'SHELL': '/bin/bash', 16:47:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:23 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:23 INFO - 'USER': 'cltbld', 16:47:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:23 INFO - 'XPC_FLAGS': '0x0', 16:47:23 INFO - 'XPC_SERVICE_NAME': '0', 16:47:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-isdc4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-a1NBtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-T6Oubo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-asDUbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-vU3nCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-aRPQCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:23 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-PvW5sH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-VMACcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-ENinkq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-DiMz0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-4x_H60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-xHMjt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-O7aS9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-0vGcin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-01iOTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:24 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-jLtaK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:25 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-tajUzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:25 INFO - Running setup.py install for manifestparser 16:47:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:25 INFO - Running setup.py install for mozcrash 16:47:25 INFO - Running setup.py install for mozdebug 16:47:25 INFO - Running setup.py install for mozdevice 16:47:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:47:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:47:25 INFO - Running setup.py install for mozfile 16:47:25 INFO - Running setup.py install for mozhttpd 16:47:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Running setup.py install for mozinfo 16:47:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Running setup.py install for mozInstall 16:47:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Running setup.py install for mozleak 16:47:26 INFO - Running setup.py install for mozlog 16:47:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Running setup.py install for moznetwork 16:47:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:47:26 INFO - Running setup.py install for mozprocess 16:47:26 INFO - Running setup.py install for mozprofile 16:47:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:47:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:47:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:47:27 INFO - Running setup.py install for mozrunner 16:47:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:47:27 INFO - Running setup.py install for mozscreenshot 16:47:27 INFO - Running setup.py install for moztest 16:47:27 INFO - Running setup.py install for mozversion 16:47:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:47:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:27 INFO - Cleaning up... 16:47:27 INFO - Return code: 0 16:47:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:27 INFO - 'HOME': '/Users/cltbld', 16:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:27 INFO - 'LOGNAME': 'cltbld', 16:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:27 INFO - 'MOZ_NO_REMOTE': '1', 16:47:27 INFO - 'NO_EM_RESTART': '1', 16:47:27 INFO - 'PAGER': '/bin/cat', 16:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:27 INFO - 'PWD': '/builds/slave/test', 16:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:27 INFO - 'SHELL': '/bin/bash', 16:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:27 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:27 INFO - 'USER': 'cltbld', 16:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:27 INFO - 'XPC_FLAGS': '0x0', 16:47:27 INFO - 'XPC_SERVICE_NAME': '0', 16:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:27 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8_teOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:28 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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-AJQtRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:28 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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-L17U7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:28 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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-8ZUu4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:28 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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-9JgIep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:28 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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-T8sB79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47: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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-oSrNN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47: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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-0pIVu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47: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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-uj5DyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47: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)) 16:47:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:28 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-2Bu5RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:29 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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-YhsXyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:29 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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-PTCA6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:29 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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-HafuFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:29 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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-BUFh1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:29 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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-HBklKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47: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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-YBECco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47: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)) 16:47:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:29 INFO - Running setup.py (path:/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/pip-NI3D3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47: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 16:47:32 INFO - Downloading blessings-1.6.tar.gz 16:47:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:32 INFO - Installing collected packages: blessings 16:47:32 INFO - Running setup.py install for blessings 16:47:32 INFO - Successfully installed blessings 16:47:32 INFO - Cleaning up... 16:47:32 INFO - Return code: 0 16:47:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:33 INFO - Reading from file tmpfile_stdout 16:47:33 INFO - Current package versions: 16:47:33 INFO - blessings == 1.6 16:47:33 INFO - blobuploader == 1.2.4 16:47:33 INFO - docopt == 0.6.1 16:47:33 INFO - functools32 == 3.2.3-2 16:47:33 INFO - jsonschema == 2.5.1 16:47:33 INFO - manifestparser == 1.1 16:47:33 INFO - mozInstall == 1.12 16:47:33 INFO - mozcrash == 1.0 16:47:33 INFO - mozdebug == 0.1 16:47:33 INFO - mozdevice == 0.48 16:47:33 INFO - mozfile == 1.2 16:47:33 INFO - mozhttpd == 0.7 16:47:33 INFO - mozinfo == 0.9 16:47:33 INFO - mozleak == 0.1 16:47:33 INFO - mozlog == 3.4 16:47:33 INFO - moznetwork == 0.27 16:47:33 INFO - mozprocess == 0.23 16:47:33 INFO - mozprofile == 0.28 16:47:33 INFO - mozrunner == 6.13 16:47:33 INFO - mozscreenshot == 0.1 16:47:33 INFO - mozsystemmonitor == 0.3 16:47:33 INFO - moztest == 0.8 16:47:33 INFO - mozversion == 1.4 16:47:33 INFO - psutil == 3.1.1 16:47:33 INFO - requests == 1.2.3 16:47:33 INFO - wsgiref == 0.1.2 16:47:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:33 INFO - 'HOME': '/Users/cltbld', 16:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:33 INFO - 'LOGNAME': 'cltbld', 16:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:33 INFO - 'MOZ_NO_REMOTE': '1', 16:47:33 INFO - 'NO_EM_RESTART': '1', 16:47:33 INFO - 'PAGER': '/bin/cat', 16:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:33 INFO - 'PWD': '/builds/slave/test', 16:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:33 INFO - 'SHELL': '/bin/bash', 16:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:33 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:33 INFO - 'USER': 'cltbld', 16:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:33 INFO - 'XPC_FLAGS': '0x0', 16:47:33 INFO - 'XPC_SERVICE_NAME': '0', 16:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47: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)) 16:47:33 INFO - Cleaning up... 16:47:33 INFO - Return code: 0 16:47:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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')]} 16:47:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:47: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 0x10b716490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b68c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff451ca36f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, '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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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 16:47: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 16:47: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 16:47:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:33 INFO - 'HOME': '/Users/cltbld', 16:47:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:33 INFO - 'LOGNAME': 'cltbld', 16:47:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:33 INFO - 'MOZ_NO_REMOTE': '1', 16:47:33 INFO - 'NO_EM_RESTART': '1', 16:47:33 INFO - 'PAGER': '/bin/cat', 16:47:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:33 INFO - 'PWD': '/builds/slave/test', 16:47:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:33 INFO - 'SHELL': '/bin/bash', 16:47:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:33 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:33 INFO - 'USER': 'cltbld', 16:47:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:33 INFO - 'XPC_FLAGS': '0x0', 16:47:33 INFO - 'XPC_SERVICE_NAME': '0', 16:47:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:47:33 INFO - Cleaning up... 16:47:33 INFO - Return code: 0 16:47:33 INFO - Running post-action listener: _resource_record_post_action 16:47:33 INFO - Running post-action listener: _start_resource_monitoring 16:47:33 INFO - Starting resource monitoring. 16:47:33 INFO - [mozharness: 2017-02-28 00:47:33.612904Z] Finished create-virtualenv step (success) 16:47:33 INFO - [mozharness: 2017-02-28 00:47:33.613869Z] Running install step. 16:47:33 INFO - Running pre-action listener: _resource_record_pre_action 16:47:33 INFO - Running main action method: install 16:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:33 INFO - Reading from file tmpfile_stdout 16:47:33 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:33 INFO - Reading from file tmpfile_stdout 16:47:33 INFO - Output received: 16:47:33 INFO - Usage: mozinstall [options] installer 16:47:33 INFO - Options: 16:47:33 INFO - -h, --help show this help message and exit 16:47:33 INFO - -d DEST, --destination=DEST 16:47:33 INFO - Directory to install application into. [default: 16:47:33 INFO - "/builds/slave/test"] 16:47:33 INFO - --app=APP Application being installed. [default: firefox] 16:47:33 INFO - mkdir: /builds/slave/test/build/application 16:47:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:47:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 16:47:55 INFO - Reading from file tmpfile_stdout 16:47:55 INFO - Output received: 16:47:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 16:47:55 INFO - Running post-action listener: _resource_record_post_action 16:47:55 INFO - [mozharness: 2017-02-28 00:47:55.107251Z] Finished install step (success) 16:47:55 INFO - [mozharness: 2017-02-28 00:47:55.107398Z] Running run-tests step. 16:47:55 INFO - Running pre-action listener: _resource_record_pre_action 16:47:55 INFO - Running main action method: run_tests 16:47:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:47:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:47:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:47:55 INFO - 2017-02-27 16:47:55.121 screenresolution[1634:10860] starting screenresolution argv=screenresolution get 16:47:55 INFO - 2017-02-27 16:47:55.124 screenresolution[1634:10860] Display 0: 1600x1200x32@60 16:47:55 INFO - 2017-02-27 16:47:55.130 screenresolution[1635:10863] starting screenresolution argv=screenresolution list 16:47:55 INFO - Available Modes on Display 0 16:47:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:47:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:47:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:47:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:47:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:47:55 INFO - Intel Iris: 16:47:55 INFO - Chipset Model: Intel Iris 16:47:55 INFO - Type: GPU 16:47:55 INFO - Bus: Built-In 16:47:55 INFO - VRAM (Dynamic, Max): 1536 MB 16:47:55 INFO - Vendor: Intel (0x8086) 16:47:55 INFO - Device ID: 0x0a2e 16:47:55 INFO - Revision ID: 0x0009 16:47:55 INFO - Displays: 16:47:55 INFO - Display: 16:47:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:47:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:47:55 INFO - Display Serial Number: 1600x1200 60 16:47:55 INFO - Main Display: Yes 16:47:55 INFO - Mirror: Off 16:47:55 INFO - Online: Yes 16:47:55 INFO - Rotation: Supported 16:47:55 INFO - Return code: 0 16:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:47:55 INFO - Python 2.7.3 16:47:55 INFO - Return code: 0 16:47:55 INFO - grabbing minidump binary from tooltool 16:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b52ad30>, '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 0x10b390db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b522b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:47:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:47:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:47:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:47:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:47:55 INFO - Return code: 0 16:47:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:47:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:47:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:47:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:47:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 16:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0090 --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 16:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.TG5j0zLRGo/Render', 16:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:47:55 INFO - 'HOME': '/Users/cltbld', 16:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:47:55 INFO - 'LOGNAME': 'cltbld', 16:47:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:47:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:55 INFO - 'MOZ_NO_REMOTE': '1', 16:47:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:47:55 INFO - 'NO_EM_RESTART': '1', 16:47:55 INFO - 'PAGER': '/bin/cat', 16:47:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:55 INFO - 'PWD': '/builds/slave/test', 16:47:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:47:55 INFO - 'SHELL': '/bin/bash', 16:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gR3eWbuw3V/Listeners', 16:47:55 INFO - 'TMPDIR': '/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/', 16:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:47:55 INFO - 'USER': 'cltbld', 16:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:55 INFO - 'XPC_FLAGS': '0x0', 16:47:55 INFO - 'XPC_SERVICE_NAME': '0', 16:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:47:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0090', '--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 16:47:55 INFO - mozversion application_buildid: 20170227142922 16:47:55 INFO - mozversion application_changeset: caca7170b92ee7874322eba772c15c9416a5ef5d 16:47:55 INFO - mozversion application_display_name: Firefox 16:47:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:47:55 INFO - mozversion application_name: Firefox 16:47:55 INFO - mozversion application_remotingname: firefox 16:47:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 16:47:55 INFO - mozversion application_vendor: Mozilla 16:47:55 INFO - mozversion application_version: 52.0 16:47:55 INFO - mozversion platform_buildid: 20170227142922 16:47:55 INFO - mozversion platform_changeset: caca7170b92ee7874322eba772c15c9416a5ef5d 16:47:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 16:47:55 INFO - mozversion platform_version: 52.0 16:47:55 INFO - using testdate: 1488242875 16:47:55 INFO - actual date: 1488242875 16:47:55 INFO - starting webserver on 'localhost:49240' 16:47:55 INFO - SUITE-START | Running 2 tests 16:47:55 INFO - TEST-START | dromaeo_css 16:47:55 INFO - operating with platform_type : mac_ 16:47:55 INFO - Initialising browser for dromaeo_css test... 16:47:55 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp2zmBJT/profile http://localhost:49240/getInfo.html) 16:47:58 INFO - PROCESS | 1645 | 2017-02-27 16:47:58.808 plugin-container[1649:11047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e4f, name = 'com.apple.tsm.portname' 16:47:58 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:47:58 INFO - PROCESS | 1645 | 2017-02-27 16:47:58.809 plugin-container[1649:11047] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 16:47:58 INFO - PROCESS | 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:47:58 INFO - PROCESS | 1645 | 2017-02-27 16:47:58.809 plugin-container[1649:11047] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:47:58 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 16:47:58 INFO - PROCESS | 1645 | colorDepth:24 16:47:58 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 16:47:58 INFO - PROCESS | 1645 | __metrics 16:47:58 ERROR - PROCESS | 1645 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 16:47:59 INFO - TEST-INFO | 1645: exit 0 16:47:59 INFO - Browser initialized. 16:47:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:47:59 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmp2zmBJT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:02 INFO - PROCESS | 1650 | 2017-02-27 16:48:02.142 plugin-container[1651:11181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 16:48:02 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:48:02 INFO - PROCESS | 1650 | 2017-02-27 16:48:02.143 plugin-container[1651:11181] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 16:48:02 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 16:48:02 INFO - PROCESS | 1650 | 2017-02-27 16:48:02.143 plugin-container[1651:11181] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 16:48:11 INFO - PROCESS | 1650 | RSS: Main: 177418240 16:48:11 INFO - PROCESS | 1650 | 16:51:14 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 16:51:16 INFO - PROCESS | 1650 | RSS: Main: 181768192 16:51:16 INFO - PROCESS | 1650 | 16:54:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 16:54:19 INFO - PROCESS | 1650 | RSS: Main: 193515520 16:54:19 INFO - PROCESS | 1650 | 16:57:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 16:57:22 INFO - PROCESS | 1650 | RSS: Main: 198537216 16:57:22 INFO - PROCESS | 1650 | 17:00:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 17:00:24 INFO - PROCESS | 1650 | RSS: Main: 202280960 17:00:24 INFO - PROCESS | 1650 | 17:03:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 17:03:28 INFO - PROCESS | 1650 | RSS: Main: 203751424 17:03:28 INFO - PROCESS | 1650 | 17:06:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 17:06:31 INFO - PROCESS | 1650 | RSS: Main: 204374016 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | __start_tp_report 17:06:31 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 17:06:31 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 17:06:31 INFO - PROCESS | 1650 | |i|pagename|runs| 17:06:31 INFO - PROCESS | 1650 | |0;dojo.html;3505.2288496530764;3589.4615807628834;3592.9101772455683;3601.36976029195;3630.1106228973904;5311.362636483617;5431.348238211411;5891.941080589193;5965.821025369235;6014.969925150368;5970.8805823883495;6044.9697751511185;6059.848503787408;6065.21152250208;6068.453839154476;5364.329458817648;5387.299651045359;5393.757280922348;5420.186971954218;5506.119020956648;5464;5468.72656367182;5494.752736126864;5499.917501237484;5510.283663123788;5298.23175639532;5301.575873930076;5471;5487.176923461473;5533.667979921198;5368.731563421813;5394.757235924393;5407.945920540823;5411.621186516945;5433.347998240197;5281.524662780368;5346.572274218053;5354.437784032699;5358.839234822962;5387.272718183034;5679.943200567983;5973.761049558012;5975.940240597582;6013.669248191348;6028.96985515074;5766.279215098113;6113.052476866093;6187.8143655689955;6187.845303867394;6217.96891015542;6301.7164227609865;6364.1408409865;6366.236051673783;6373.776917807901;6406.679666016727;6000.36996115406;6000.879982400327;6021.849453763691;6024.1566180734735;6047.5766696331275;6236.158118653923;6351.904721429182;6498.9350106498805;6516.869662606721;6542.803715888531;6146.678464130144;6158.907616385758;6202.472789812917;6210.285817130997;6256.874862502725;6325.272593651789;6326.430621244018;6389.7763578274535;6390.360963903572;6397.296297407282;6180.752769889244;6299.401556852092;6316.873662526724;6320.462760665303;6326;6125.235451818339;6192.473639740582;6238.594491358047;6253.437190652863;6286.49708023357;5122.769475373617;5134.589232861362;5136.43499215086;5137.306463627438;5157.252198431206;3754.2866855297407;4507.842225522091;4542.227821270392;4593.770311484413;4601.746903920316;5689.68706721126;6069.453749162597;6102.69486525672;6144.047672610753;6193.442590166816;5454.863628409242;5966.940330596725;6395.584287021329;6398.424141827258;6464.095026696266;5999.520038396918;6062.42406971337;6150.876982460326;6160.845978850475;6201.6899155042065;4512.819487220474;5587.636803607834;5636.887262254732;5654.180143879114;5684.062129748628;6560.770373036921;6568.901466477911;6610.239822420387;6615.338466153346;6636.43590294811;6195.938040619536;6234.438900498795;6350.7142178603;6382.68086595659;6398.48812095022;5159.432462429205;5829.621074630136;6131.804871721949;6476.902846457401;6488;5240.502152295526;6320.5575609706875;6328.746850125944;6338.049292606146;6353.777617783356;6164.47601953839;6387.680615969276;6396;6419.646919419477;6434.710438030394;6071.574989750675;6144.801763656044;6222.782202622887;6241.625502469867;6267.2792628848265;6221.377862213923;6246.718897649525;6254.405831446005;6273.874522509615;6309.274433440213;6162.506999440124;6223.875522489616;6242.563020588515;6265.27949285838;6279.654618995999;6134.222293197161;6148.893199224004;6202.162708034538;6212.751489940351;6224.470919971853;6213.316535181217;6222.875542489215;6225.533085018551;6231.657258850807;6245.968770156302 17:06:31 INFO - PROCESS | 1650 | |1;ext.html;468.2884058765212;468.723453162634;481.4848112519601;502.5150729545988;545.3946119807014;40076.19847603046;41887.79056104723;41893.371599426;43738.78130609351;43772.34341484872;43546.56453435465;43812.780936095354;43977.56022439775;44008.559914400845;44029.33955990655;9524.571394287257;9671.854922176173;9734.902650973507;9740.707778766648;9809.215262778996;8975.281977441822;9027.503487308195;9055.818883622323;9077.046910074447;9079.137481939239;9065.22945549629;9075.319351048665;9083;9103.63585456581;9105.453672779622;9048.004719480885;9054;9098.77253068672;9117.726468205965;9123.680671176477;9675.274354423447;9739.366941148803;9753.609855605768;9763.316567840255;9771.853422198672;40972.795136024426;41021.589784102376;41310.586894130975;41456.79271603653;41476.79261603673;3268.7711860169798;3635.054885729703;3752.8686495972784;3812.1994381179984;3813.771173729585;26541.73458265412;30055.098347049625;30312.69687303143;31689.841550792098;31951.680483195334;3278.098522906196;3298.4062868683627;3375.902831579722;3417.3848707232687;3418.8119653419053;356650;357974.9999999974;361976;362043;362212.18893905624;60612.18163455103;60756;60796;60975.39024609697;60982.39017609856;61740.69129654323;62118.68940655268;64159;64194.716105677624;64361.35638643554;16689.582760431087;16721.414750483676;16922.15389230558;16933.661326773396;17011.829881701025;12623.179493332904;13009.284489352987;13045.608631741063;13053.955683545293;13065.281409522377;16958.23687934046;16967.83032169687;17047.977121372758;17080;17099.23053462597;6949.339812717783;6978.302169782981;7011.8597628047155;7016.929830701628;7085.610291434021;846.4032856835915;936.9531523423801;970.5729479029204;997.1125698128672;1031.0514326819343;24142.03431862706;27809;29360.559591606143;30149.698503015126;30579.847100764353;839.7312859884778;1006.4917216805612;1026.5431882812077;1049.5854137615752;1095.7917995580815;12811.871881281255;14370.640733981734;15119.017263877813;15474.22628868552;16379.771517136263;626266;658569;658985;662753;665397;53056.67358316073;58615.70692146512;59357.70321148367;59447.702761486784;59594.51013724605;1335.2856221921224;1358.7554240236852;1375.40170026037;1383.0456984680739;1385.217352196006;29448.852755736083;30233.69766302397;30516.08451746451;30742.385152297276;30926.22684432907;54460.72769636127;58256.708716456145;58415;58424.4157558436;58499.4150058511;587404;588225;594840;595292;595600;26835.389876607467;27024.864875675496;27151.321216969733;27180.864095679393;27214.72785272201;47321.76339118282;47724.284135738686;48507;48807;49189.262161066894;31924.6807531931;37262.81368593248;37376.62623373731;38956.02609934774;38958.80520597379;31912.840435797672;38658.2268354637;38797.642082526974;39533.40699889446;39988;38255.61744382632;38483.615163848;39127;39137;40351.59648403478;30944;32926.34147316992;34303.4854477178;35013.94958151259;35035.29929401448;25491.36271593225;25581.23256302314;25853.741462585134;25901.35246618774;26179.738202618493 17:06:31 INFO - PROCESS | 1650 | |2;jquery.html;351.27987625367996;382.16306289226594;391.1102242398544;397.6381492841515;412.77503760450554;17923.283068677236;20023.699644505345;20624.99999999998;20786.792132078674;20874.89562552187;19097.14062867171;19528.21887124513;19808;20057.29799457019;20290.188392464283;5715.628484148538;5799.304083509985;5871.765129394819;5873.85315367115;5983.760649574012;5689.886202275973;5785.27684039495;5940.821775346746;5943.910841337383;5945.821625351246;6106.328303886569;6142.416470435302;6147.907781383283;6179.536534759888;6182.103594978726;5864.325602555697;6141.631502109843;6169.074638804171;6176.320604733476;6208.379162083756;6023.277206735176;6034.939650603482;6041.1240370146525;6046.879062418771;6064.848378790522;13190.4064317105;13279.601611951657;13521.459141634323;13572.389242484112;13616.114952528153;2030.2082187946712;2176.379731776436;2239.3505883293824;2299.586074506588;2522.9116980905765;8945.821083578292;9369.76575585609;10039.799204015952;10584.470776461147;10607.15142788575;1775.112443778111;1784.643071385728;1897.8007309232607;1909.9427017189369;1942.417274817549;117807.8219217814;119330.40334798358;121568;123722;123941;10158.39049657023;10976.506057227443;11784.764304713857;11808.88191118095;12022.519099235933;14810.925945370203;14867.553973380816;14870.70258594822;14892.329845156994;14919.328630211667;8374.874376884352;8618;8649;8717.869231961526;8814.735557933273;8584;8607.48355098696;8625.870611940825;8752.993405758292;8768.430052046597;4499.977500112478;4561.749103799323;4580.610648094883;4644.256918892961;4670.182718024332;1590.403598650506;1652.900825950447;1899.705545640428;1949.6198241343086;1959.0302800114034;752.9849403012018;874.6486678082377;929.2983797233181;966.8839739231337;1029.9485025748684;20063.799362006484;20940.057697403652;21016.789832101484;21131.8943405282;21187.78812211889;851.9148085191431;898.9775255618662;917.3624331089828;965.7537327981461;980.4803454169302;6773.729050837911;10569.682909512727;11126.38804865724;11127.554897804159;11180.496877640526;578068;580013.0999344976;609774;617403;620542;133907;145037;146557;148919;149591;845.9383473740417;933.2300851797295;971.2909576009553;1003.5734812704571;1011.7723512209694;18338.899666020083;18672;19016;19186.712199316742;19462.416127516197;52784.20823687571;53268.73365633147;54125.72937135289;55635;58227.4177258222;60597;73762.89355659562;76046;80809.78785318107;81401.3719725614;7908.446408751563;11674.70813229676;12174.75650487003;12314.75370492603;12956.416961236955;13033.804492932803;13534.526291579747;13766.449342026206;13805.585832425044;14104.36530356157;9352.67265645699;11611.361375124448;11852.644420667393;11910.404479776149;12245.877541224474;11637.53449861996;11789.351585662871;11803;11865.228760130563;12124.636260912186;11897.107716921093;11898.643040708792;12121.818172727593;12154.209976351509;12309.44607492683;12584.244945303311;12708.173968692005;12783.23300601967;12981.480740770641;13084.018698597452;11847.644570662895;11881.524739010689;12189.024878009915;12194.51221951112;12221.511139554319 17:06:31 INFO - PROCESS | 1650 | |3;mootools.html;1460.1895947749;1495.8205015398155;1681.730923052312;1793.461961411576;1831.8534517238622;7996.400269979753;8197.672093116269;8402.747917562476;8460.32317414606;8483.36374771893;8322.501949649077;8450.98588169419;8462.788430289245;8483.872741908861;8491.575421228945;2356.163561935514;2370.383700237933;2372.193454225563;2373.821963352747;2387.832851700373;2364.798992085666;2393.5212957408503;2394.1022116706235;2403.8317317787673;2410.2648692148887;2083.906224219906;2319.585053117597;2348.5420343033115;2357.1867705641525;2386.916457923973;2326.7207935047904;2332.3352844439337;2355.057976809273;2360.929172124839;2373.442241073355;1997.8801271923585;2370.9051637934463;2387.8089752819733;2391.940201494959;2399.9520009599887;8390.03514595817;8460.788480288042;8478.872816907751;8511.191436813555;8526.360522960802;4810.158222311082;5057.367829021372;5065.1642478990925;5111.258867464197;5240.187770895517;2803.4112836304403;3424.6746559076846;3497.667721566447;3510.1926556891804;3558.804265765382;999.115782532464;1028.275066078413;1079.7192729890207;1087.6193332333698;1090.8145615245428;10726.678199654023;10769.299995500267;10829.241953063289;10854.78290434187;10935.453227338681;4275.657947364203;4440.800163992628;4523.072770082125;4536.931946020813;4537.500874903758;8663.48019118855;8683.044865064838;8689.435186712843;8715.259202967818;8717.782055448664;5121.820736274287;5127.79488820443;5142.0744266031725;5162.1224391853475;5238.7904483820985;3779.829907654162;3962.881113566598;4154.1068670236045;4740.265258884879;4775;3249.821259830732;3599.9640003600152;3679.19057807282;3752.380857158593;3807.9428808567895;1144.7481554058095;1152.472973310367;1156.9768604627861;1158.449736375215;1161.9825702614467;867.4101610904645;876.9035406105323;900.8288425199191;909.663424532927;921.4102974096584;5623.072193088176;5704.458076482728;5706.9429305707245;5769.865149894482;5921.644701317935;846.2975730143966;906.2342320738965;929.9116583924516;959.0553304994575;990.5443495991781;3845.1732877431486;3886.8639597613947;3901.3757798752063;3934.7639141651593;3941.7832019239218;9855.507224638883;10198.694039178836;10203.979602039884;10206.387616743019;10216.795664086676;10070.345427547187;10075.445850478294;10101.69694909154;10120.443375614264;10125.341852779546;7512.286332798375;7808.492447990862;7855;7856;7956.761297161094;5721.942780572141;5842.503387212135;5846.883062338815;5862.179294898803;5981.700914954322;9072.410293330913;9283.257339412696;9344.719658410258;9427.387219830689;9445;9198.724038278862;9352.205062569758;9454.480003599869;9531.714048578553;9643.373180743229;5963.582549221513;7096.822579435556;7131;7193.4604904631315;7280.271972802678;7937.40469464804;8005.519668819889;8011.479253848481;8037.23646253605;8037.7588672339925;7018.719251229893;7130.037444945074;7145.785626431215;7211.42308615299;7239.746608868664;6967.229473516179;7058;7067.6819543119655;7131;7176.06711127571;6689.063531105552;6697.799066028027;6760.222574404006;6797.6941037654415;6902.827429314308;4805.351277577623;4839.1531481989805;4857.101436234308;4870.586000189882;4935.580475659609;4717.268823332389;4774.3315935769715;4782.33047373361;4871.780769865435;4879.658423910292 17:06:31 INFO - PROCESS | 1650 | |4;prototype.html;264.62687610469237;313.4811886328128;322.7547064231184;325.9217787730945;326.54936188060475;5290.836016076457;5389.461053894609;5482.889087701234;5490.7529161187795;5526.502614764676;5234;5330.866728331794;5419.783208671648;5429.837104886859;5440.095966411764;4147.817871906507;4170.833166673329;4171.519110715698;4174.97912510437;4178.895527611804;3641.362761516724;3810.333191691443;4088.7955602219918;4143.274926887798;4184.225918205127;3679.374506333916;3686.6313368663186;3898.927794856423;4046.433499310099;4122.97938510307;3871.547720121854;3978.7214894957365;4080.571539988303;4089.6114869087387;4120.979395103035;3388.7797293175863;3491.389006923778;3515.3145136698354;3516.929661406783;3552.520409744703;5187.533122019036;5247.317848679685;5261.344055140739;5280.841574752763;5287.841364759025;4026.1545075534173;4660.906781864378;4676.321933319649;4682.859514214579;4702.717836929795;5332.706701131437;5490.8153271102665;5556.277683901067;5594.58040646949;5597.020521408737;3865.2849222893856;3894.785786781726;3903.473031140788;3904.941425878614;3916.941245881314;4915.5330243626795;5702.771889124471;5782.421757824226;6013.488853447462;6022.367651396584;3512.332656795201;3670.5778835433734;3709.536307961505;3773.339665558516;3952.980235098806;3040.9239769005953;3367.562216911786;3521.876734314338;3947.2500224957166;3995.320795464778;4162.812673429703;4383.62739167168;4649.837255696035;4660.557247061523;4661.743604101739;4704.95295047052;5083.389993200765;5373.2746079278795;5696.82909512707;5712.200291959129;1270.4791035675328;1276.5149243287676;1310.5020092364841;1316.8214448068925;1320.221069568959;760.68811787167;762.9389648828192;804.4730701390598;819.418213068716;829.6847198064697;5100.719460429712;5125.513076257749;5247.921281180786;5251.343582052244;5253.791627925599;4567.474740404829;5054.671446355975;5565.41563135873;5655.293088363955;5703.3764468345025;4993;5190.923630547735;5192.170267204383;5204.9219261711105;5240.737963101829;2658.441727237263;2779.9722002779713;2794.455081259135;2955.1825627239095;2956.5712971618996;5008.974955125201;5789.3921138279875;5798.797042103506;5800.274965629296;5820.738066787005;4609.677322587454;5145.044882944457;5725.454127385583;5747.850429914034;5785.739641716133;4726.409198850144;5378;5832.329282132524;5835.336928975222;5870.5010074144175;4906.116898958079;5561.610687252015;5615.945648916008;5630.521405680399;5642.322921249476;4735.976320118378;4774.832880849292;5534.667919924817;5539.002979463574;5573.5819813513335;4829.864981729361;4842.716680079852;5203.869903252297;5276.868078298074;5333.7333133343955;3011.623547056618;3183.872645094263;3625.619309972415;3736.9626303736613;3926.290859307069;4927.630427717864;5210.557102646318;5247.5539579134675;5438.374586922397;5850.678212698343;4977.590350609844;5002.674826136289;5709.628874123168;5725.227094342377;5726.828195154152;4579.335996280587;5109.748111712505;5461.86987075049;5645.887082258414;5670.631408958405;5406.972965135306;5528.917066243929;5530.889382212253;5566.832995010156;5626.35296940857;4257.6168144867115;5665.150227465913;5683.60214784961;5698.430156984268;5701.6864072474755;4160.91678166441;4497.527759585197;4625.606823420047;5262.842114736411;5743.8851222976145 17:06:31 INFO - PROCESS | 1650 | |5;yui.html;693.8751024815534;704.3766266853835;761.8590560746259;766.7661363284196;782.1357400072922;12570.874291257085;13150.736985260313;14226.288685565733;15261;15300.234988250584;14507.129572225675;14828.406863725439;15069.246537673127;15205.619859503518;15446.768298475503;857.6226460357439;868.4919322196523;873.458455757428;873.7509809704236;873.829603227371;853.5817449449756;882.0738224863867;886.0607755778894;887.40987243483;887.5473508510673;888.3958907942597;900.7252787899688;930.7905721212707;935.6678379175397;935.8034812689343;897.5422534507383;924.1543987251657;929.2844509727539;931.5807886451124;932.3846261467432;694.2432748304323;695.0824911117327;696.7979286007052;697.052009267396;698.3156506623537;11727.7068073298;13893.513727019606;14551.70896582073;14594.927025364912;14651;13452.798208026887;13682.247476388795;13689.247091409969;13777.586672399844;13862.376193071335;11006.174536909684;11140.721481962935;11146.164037697205;11446.255993360404;12029.639110826689;3571.2678900825267;3657.1588534636917;3761.586225515191;3861.6331448512346;3895.9610403896163;68268.6586567069;95784;95790.52104739432;98675;99197;10503.842442363371;10592.15262778976;10702.250842440955;10705.250632455809;10737.731556711145;19591.608167836563;21070.47323816917;21143.365699029055;21164.682529762067;21189.15243390278;7026.229068189564;7978.920210797934;7997.400194985399;8016;8065.7176998805935;4231.957680423218;4303.117860838521;4401.559844015573;4425.35832304314;4444;3405.523226748257;3534.0634731796094;3585.462180672868;3590.2101537661674;3590.281943611236;679.2799632389683;682.9795106146823;690.2821066091209;693.6947742993067;725.4341613541446;583.3175185033521;633.7971849008366;636.4303947966637;655.4985436141355;661.9743584631044;7795.064592248853;9012.81974360509;9485.478298693639;9514.096160864707;9584.616615335308;524.2607922828793;528.9788408463695;529.3462573721451;552.7181137619842;580.8373655376502;4125.658073605414;4161.8335266589;4164.75011499311;4374.103308821747;4388.846390376321;104248;115371;119441;119865;124130;76052.23947760562;77217.6139119312;79547.60226198832;82080.58959705163;85222.57388713141;56587;71453;73051;74605.25394745983;76584.23415765772;9539;9549.856752148862;9679.128878400978;9705.223582113555;9719.514024298898;45910;47518.5248147528;48353.5164648349;50815.237771432716;51356;72931.27068729245;75828.62085689757;76253.23746762684;76595;81769;12532.122751407314;12668.683282918;12960.740785184433;13127.212367257995;13302.068855180045;13971.510997115052;14266.215358155401;14289.857101428852;14454.927725361727;14496.927515362777;13123.737525249251;13175.934120329337;13430.127041742646;13548.458061677817;13613.251271179784;12892.484300628244;12945.288009159587;13387.263700496176;13556.93221533886;13907.58277251684;12667.80998285045;13241.602751917459;13273.203607783564;13513.324333783468;13691.520796772065;10418.374897506174;10693.732656683645;10769.438296554416;11074.28017178913;11332.263402878787;9981.251406144713;10986.780264394507;11252.324860508395;11551.826722599335;11563.248388854698 17:06:31 INFO - PROCESS | 1650 | __end_tp_report 17:06:31 INFO - PROCESS | 1650 | __start_cc_report 17:06:31 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,356 17:06:31 INFO - PROCESS | 1650 | __end_cc_report 17:06:31 INFO - PROCESS | 1650 | __startTimestamp1488243991161__endTimestamp 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | ------- Summary: start ------- 17:06:31 INFO - PROCESS | 1650 | Number of tests: 6 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5881.00 Median:6144.80 stddev:640.64 (10.4%) stddev-sans-first:614.90 17:06:31 INFO - PROCESS | 1650 | Values: 3505.2 3589.5 3592.9 3601.4 3630.1 5311.4 5431.3 5891.9 5965.8 6015.0 5970.9 6045.0 6059.8 6065.2 6068.5 5364.3 5387.3 5393.8 5420.2 5506.1 5464.0 5468.7 5494.8 5499.9 5510.3 5298.2 5301.6 5471.0 5487.2 5533.7 5368.7 5394.8 5407.9 5411.6 5433.3 5281.5 5346.6 5354.4 5358.8 5387.3 5679.9 5973.8 5975.9 6013.7 6029.0 5766.3 6113.1 6187.8 6187.8 6218.0 6301.7 6364.1 6366.2 6373.8 6406.7 6000.4 6000.9 6021.8 6024.2 6047.6 6236.2 6351.9 6498.9 6516.9 6542.8 6146.7 6158.9 6202.5 6210.3 6256.9 6325.3 6326.4 6389.8 6390.4 6397.3 6180.8 6299.4 6316.9 6320.5 6326.0 6125.2 6192.5 6238.6 6253.4 6286.5 5122.8 5134.6 5136.4 5137.3 5157.3 3754.3 4507.8 4542.2 4593.8 4601.7 5689.7 6069.5 6102.7 6144.0 6193.4 5454.9 5966.9 6395.6 6398.4 6464.1 5999.5 6062.4 6150.9 6160.8 6201.7 4512.8 5587.6 5636.9 5654.2 5684.1 6560.8 6568.9 6610.2 6615.3 6636.4 6195.9 6234.4 6350.7 6382.7 6398.5 5159.4 5829.6 6131.8 6476.9 6488.0 5240.5 6320.6 6328.7 6338.0 6353.8 6164.5 6387.7 6396.0 6419.6 6434.7 6071.6 6144.8 6222.8 6241.6 6267.3 6221.4 6246.7 6254.4 6273.9 6309.3 6162.5 6223.9 6242.6 6265.3 6279.7 6134.2 6148.9 6202.2 6212.8 6224.5 6213.3 6222.9 6225.5 6231.7 6246.0 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:67712.45 Median:40662.20 stddev:147326.80 (362.3%) stddev-sans-first:147653.58 17:06:31 INFO - PROCESS | 1650 | Values: 468.3 468.7 481.5 502.5 545.4 40076.2 41887.8 41893.4 43738.8 43772.3 43546.6 43812.8 43977.6 44008.6 44029.3 9524.6 9671.9 9734.9 9740.7 9809.2 8975.3 9027.5 9055.8 9077.0 9079.1 9065.2 9075.3 9083.0 9103.6 9105.5 9048.0 9054.0 9098.8 9117.7 9123.7 9675.3 9739.4 9753.6 9763.3 9771.9 40972.8 41021.6 41310.6 41456.8 41476.8 3268.8 3635.1 3752.9 3812.2 3813.8 26541.7 30055.1 30312.7 31689.8 31951.7 3278.1 3298.4 3375.9 3417.4 3418.8 356650.0 357975.0 361976.0 362043.0 362212.2 60612.2 60756.0 60796.0 60975.4 60982.4 61740.7 62118.7 64159.0 64194.7 64361.4 16689.6 16721.4 16922.2 16933.7 17011.8 12623.2 13009.3 13045.6 13054.0 13065.3 16958.2 16967.8 17048.0 17080.0 17099.2 6949.3 6978.3 7011.9 7016.9 7085.6 846.4 937.0 970.6 997.1 1031.1 24142.0 27809.0 29360.6 30149.7 30579.8 839.7 1006.5 1026.5 1049.6 1095.8 12811.9 14370.6 15119.0 15474.2 16379.8 626266.0 658569.0 658985.0 662753.0 665397.0 53056.7 58615.7 59357.7 59447.7 59594.5 1335.3 1358.8 1375.4 1383.0 1385.2 29448.9 30233.7 30516.1 30742.4 30926.2 54460.7 58256.7 58415.0 58424.4 58499.4 587404.0 588225.0 594840.0 595292.0 595600.0 26835.4 27024.9 27151.3 27180.9 27214.7 47321.8 47724.3 48507.0 48807.0 49189.3 31924.7 37262.8 37376.6 38956.0 38958.8 31912.8 38658.2 38797.6 39533.4 39988.0 38255.6 38483.6 39127.0 39137.0 40351.6 30944.0 32926.3 34303.5 35013.9 35035.3 25491.4 25581.2 25853.7 25901.4 26179.7 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:35615.87 Median:11160.20 stddev:100853.12 (903.7%) stddev-sans-first:101101.28 17:06:31 INFO - PROCESS | 1650 | Values: 351.3 382.2 391.1 397.6 412.8 17923.3 20023.7 20625.0 20786.8 20874.9 19097.1 19528.2 19808.0 20057.3 20290.2 5715.6 5799.3 5871.8 5873.9 5983.8 5689.9 5785.3 5940.8 5943.9 5945.8 6106.3 6142.4 6147.9 6179.5 6182.1 5864.3 6141.6 6169.1 6176.3 6208.4 6023.3 6034.9 6041.1 6046.9 6064.8 13190.4 13279.6 13521.5 13572.4 13616.1 2030.2 2176.4 2239.4 2299.6 2522.9 8945.8 9369.8 10039.8 10584.5 10607.2 1775.1 1784.6 1897.8 1909.9 1942.4 117807.8 119330.4 121568.0 123722.0 123941.0 10158.4 10976.5 11784.8 11808.9 12022.5 14810.9 14867.6 14870.7 14892.3 14919.3 8374.9 8618.0 8649.0 8717.9 8814.7 8584.0 8607.5 8625.9 8753.0 8768.4 4500.0 4561.7 4580.6 4644.3 4670.2 1590.4 1652.9 1899.7 1949.6 1959.0 753.0 874.6 929.3 966.9 1029.9 20063.8 20940.1 21016.8 21131.9 21187.8 851.9 899.0 917.4 965.8 980.5 6773.7 10569.7 11126.4 11127.6 11180.5 578068.0 580013.1 609774.0 617403.0 620542.0 133907.0 145037.0 146557.0 148919.0 149591.0 845.9 933.2 971.3 1003.6 1011.8 18338.9 18672.0 19016.0 19186.7 19462.4 52784.2 53268.7 54125.7 55635.0 58227.4 60597.0 73762.9 76046.0 80809.8 81401.4 7908.4 11674.7 12174.8 12314.8 12956.4 13033.8 13534.5 13766.4 13805.6 14104.4 9352.7 11611.4 11852.6 11910.4 12245.9 11637.5 11789.4 11803.0 11865.2 12124.6 11897.1 11898.6 12121.8 12154.2 12309.4 12584.2 12708.2 12783.2 12981.5 13084.0 11847.6 11881.5 12189.0 12194.5 12221.5 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5443.73 Median:5088.21 stddev:2978.85 (58.5%) stddev-sans-first:2972.16 17:06:31 INFO - PROCESS | 1650 | Values: 1460.2 1495.8 1681.7 1793.5 1831.9 7996.4 8197.7 8402.7 8460.3 8483.4 8322.5 8451.0 8462.8 8483.9 8491.6 2356.2 2370.4 2372.2 2373.8 2387.8 2364.8 2393.5 2394.1 2403.8 2410.3 2083.9 2319.6 2348.5 2357.2 2386.9 2326.7 2332.3 2355.1 2360.9 2373.4 1997.9 2370.9 2387.8 2391.9 2400.0 8390.0 8460.8 8478.9 8511.2 8526.4 4810.2 5057.4 5065.2 5111.3 5240.2 2803.4 3424.7 3497.7 3510.2 3558.8 999.1 1028.3 1079.7 1087.6 1090.8 10726.7 10769.3 10829.2 10854.8 10935.5 4275.7 4440.8 4523.1 4536.9 4537.5 8663.5 8683.0 8689.4 8715.3 8717.8 5121.8 5127.8 5142.1 5162.1 5238.8 3779.8 3962.9 4154.1 4740.3 4775.0 3249.8 3600.0 3679.2 3752.4 3807.9 1144.7 1152.5 1157.0 1158.4 1162.0 867.4 876.9 900.8 909.7 921.4 5623.1 5704.5 5706.9 5769.9 5921.6 846.3 906.2 929.9 959.1 990.5 3845.2 3886.9 3901.4 3934.8 3941.8 9855.5 10198.7 10204.0 10206.4 10216.8 10070.3 10075.4 10101.7 10120.4 10125.3 7512.3 7808.5 7855.0 7856.0 7956.8 5721.9 5842.5 5846.9 5862.2 5981.7 9072.4 9283.3 9344.7 9427.4 9445.0 9198.7 9352.2 9454.5 9531.7 9643.4 5963.6 7096.8 7131.0 7193.5 7280.3 7937.4 8005.5 8011.5 8037.2 8037.8 7018.7 7130.0 7145.8 7211.4 7239.7 6967.2 7058.0 7067.7 7131.0 7176.1 6689.1 6697.8 6760.2 6797.7 6902.8 4805.4 4839.2 4857.1 4870.6 4935.6 4717.3 4774.3 4782.3 4871.8 4879.7 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4472.19 Median:5069.03 stddev:1378.84 (27.2%) stddev-sans-first:1346.06 17:06:31 INFO - PROCESS | 1650 | Values: 264.6 313.5 322.8 325.9 326.5 5290.8 5389.5 5482.9 5490.8 5526.5 5234.0 5330.9 5419.8 5429.8 5440.1 4147.8 4170.8 4171.5 4175.0 4178.9 3641.4 3810.3 4088.8 4143.3 4184.2 3679.4 3686.6 3898.9 4046.4 4123.0 3871.5 3978.7 4080.6 4089.6 4121.0 3388.8 3491.4 3515.3 3516.9 3552.5 5187.5 5247.3 5261.3 5280.8 5287.8 4026.2 4660.9 4676.3 4682.9 4702.7 5332.7 5490.8 5556.3 5594.6 5597.0 3865.3 3894.8 3903.5 3904.9 3916.9 4915.5 5702.8 5782.4 6013.5 6022.4 3512.3 3670.6 3709.5 3773.3 3953.0 3040.9 3367.6 3521.9 3947.3 3995.3 4162.8 4383.6 4649.8 4660.6 4661.7 4705.0 5083.4 5373.3 5696.8 5712.2 1270.5 1276.5 1310.5 1316.8 1320.2 760.7 762.9 804.5 819.4 829.7 5100.7 5125.5 5247.9 5251.3 5253.8 4567.5 5054.7 5565.4 5655.3 5703.4 4993.0 5190.9 5192.2 5204.9 5240.7 2658.4 2780.0 2794.5 2955.2 2956.6 5009.0 5789.4 5798.8 5800.3 5820.7 4609.7 5145.0 5725.5 5747.9 5785.7 4726.4 5378.0 5832.3 5835.3 5870.5 4906.1 5561.6 5615.9 5630.5 5642.3 4736.0 4774.8 5534.7 5539.0 5573.6 4829.9 4842.7 5203.9 5276.9 5333.7 3011.6 3183.9 3625.6 3737.0 3926.3 4927.6 5210.6 5247.6 5438.4 5850.7 4977.6 5002.7 5709.6 5725.2 5726.8 4579.3 5109.7 5461.9 5645.9 5670.6 5407.0 5528.9 5530.9 5566.8 5626.4 4257.6 5665.2 5683.6 5698.4 5701.7 4160.9 4497.5 4625.6 5262.8 5743.9 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20057.92 Median:4395.20 stddev:29099.89 (662.1%) stddev-sans-first:29145.20 17:06:31 INFO - PROCESS | 1650 | Values: 693.9 704.4 761.9 766.8 782.1 12570.9 13150.7 14226.3 15261.0 15300.2 14507.1 14828.4 15069.2 15205.6 15446.8 857.6 868.5 873.5 873.8 873.8 853.6 882.1 886.1 887.4 887.5 888.4 900.7 930.8 935.7 935.8 897.5 924.2 929.3 931.6 932.4 694.2 695.1 696.8 697.1 698.3 11727.7 13893.5 14551.7 14594.9 14651.0 13452.8 13682.2 13689.2 13777.6 13862.4 11006.2 11140.7 11146.2 11446.3 12029.6 3571.3 3657.2 3761.6 3861.6 3896.0 68268.7 95784.0 95790.5 98675.0 99197.0 10503.8 10592.2 10702.3 10705.3 10737.7 19591.6 21070.5 21143.4 21164.7 21189.2 7026.2 7978.9 7997.4 8016.0 8065.7 4232.0 4303.1 4401.6 4425.4 4444.0 3405.5 3534.1 3585.5 3590.2 3590.3 679.3 683.0 690.3 693.7 725.4 583.3 633.8 636.4 655.5 662.0 7795.1 9012.8 9485.5 9514.1 9584.6 524.3 529.0 529.3 552.7 580.8 4125.7 4161.8 4164.8 4374.1 4388.8 104248.0 115371.0 119441.0 119865.0 124130.0 76052.2 77217.6 79547.6 82080.6 85222.6 56587.0 71453.0 73051.0 74605.3 76584.2 9539.0 9549.9 9679.1 9705.2 9719.5 45910.0 47518.5 48353.5 50815.2 51356.0 72931.3 75828.6 76253.2 76595.0 81769.0 12532.1 12668.7 12960.7 13127.2 13302.1 13971.5 14266.2 14289.9 14454.9 14496.9 13123.7 13175.9 13430.1 13548.5 13613.3 12892.5 12945.3 13387.3 13556.9 13907.6 12667.8 13241.6 13273.2 13513.3 13691.5 10418.4 10693.7 10769.4 11074.3 11332.3 9981.3 10986.8 11252.3 11551.8 11563.2 17:06:31 INFO - PROCESS | 1650 | -------- Summary: end -------- 17:06:31 INFO - PROCESS | 1650 | 17:06:31 INFO - TEST-INFO | 1650: exit 0 17:06:31 INFO - TEST-OK | dromaeo_css | took 1115983ms 17:06:31 INFO - TEST-START | kraken 17:06:31 INFO - operating with platform_type : mac_ 17:06:31 INFO - Initialising browser for kraken test... 17:06:31 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmphBXFru/profile http://localhost:49240/getInfo.html) 17:06:34 INFO - PROCESS | 1657 | 2017-02-27 17:06:34.508 plugin-container[1659:13315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 17:06:34 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:06:34 INFO - PROCESS | 1657 | 2017-02-27 17:06:34.508 plugin-container[1659:13315] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880f, name = 'com.apple.CFPasteboardClient' 17:06:34 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:06:34 INFO - PROCESS | 1657 | 2017-02-27 17:06:34.509 plugin-container[1659:13315] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:06:34 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 17:06:34 INFO - PROCESS | 1657 | colorDepth:24 17:06:34 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 17:06:34 INFO - PROCESS | 1657 | __metrics 17:06:34 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 17:06:35 INFO - TEST-INFO | 1657: exit 0 17:06:35 INFO - Browser initialized. 17:06:35 INFO - Running cycle 1/1 for kraken test... 17:06:35 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/T/tmphBXFru/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:37 INFO - PROCESS | 1660 | 2017-02-27 17:06:37.888 plugin-container[1661:13438] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 17:06:37 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:06:37 INFO - PROCESS | 1660 | 2017-02-27 17:06:37.888 plugin-container[1661:13438] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c27, name = 'com.apple.CFPasteboardClient' 17:06:37 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:06:37 INFO - PROCESS | 1660 | 2017-02-27 17:06:37.888 plugin-container[1661:13438] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:06:47 INFO - PROCESS | 1660 | RSS: Main: 177352704 17:06:47 INFO - PROCESS | 1660 | 17:06:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 17:06:51 INFO - PROCESS | 1660 | RSS: Main: 190476288 17:06:51 INFO - PROCESS | 1660 | 17:06:54 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 17:06:54 INFO - PROCESS | 1660 | RSS: Main: 198393856 17:06:54 INFO - PROCESS | 1660 | 17:06:58 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 17:06:58 INFO - PROCESS | 1660 | RSS: Main: 202137600 17:06:58 INFO - PROCESS | 1660 | 17:07:00 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 17:07:01 INFO - PROCESS | 1660 | RSS: Main: 203444224 17:07:01 INFO - PROCESS | 1660 | 17:07:03 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:03 INFO - PROCESS | 1660 | RSS: Main: 203579392 17:07:03 INFO - PROCESS | 1660 | 17:07:06 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:07 INFO - PROCESS | 1660 | RSS: Main: 207142912 17:07:07 INFO - PROCESS | 1660 | 17:07:10 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:11 INFO - PROCESS | 1660 | RSS: Main: 206438400 17:07:11 INFO - PROCESS | 1660 | 17:07:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 17:07:15 INFO - PROCESS | 1660 | RSS: Main: 206594048 17:07:15 INFO - PROCESS | 1660 | 17:07:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:17 INFO - PROCESS | 1660 | RSS: Main: 206045184 17:07:17 INFO - PROCESS | 1660 | 17:07:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:20 INFO - PROCESS | 1660 | RSS: Main: 206041088 17:07:20 INFO - PROCESS | 1660 | 17:07:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:07:23 INFO - PROCESS | 1660 | RSS: Main: 206061568 17:07:23 INFO - PROCESS | 1660 | 17:07:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:07:26 INFO - PROCESS | 1660 | RSS: Main: 206368768 17:07:26 INFO - PROCESS | 1660 | 17:07:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:07:30 INFO - PROCESS | 1660 | RSS: Main: 206200832 17:07:30 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 17:07:31 INFO - PROCESS | 1660 | RSS: Main: 207671296 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | __start_tp_report 17:07:31 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 17:07:31 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 17:07:31 INFO - PROCESS | 1660 | |i|pagename|runs| 17:07:31 INFO - PROCESS | 1660 | |0;ai-astar;155;140;117;109;174;173;130;117;117;117 17:07:31 INFO - PROCESS | 1660 | |1;audio-beat-detection;151;105;111;143;110;112;111;111;142;110 17:07:31 INFO - PROCESS | 1660 | |2;audio-dft;229;293;195;194;196;199;199;193;211;192 17:07:31 INFO - PROCESS | 1660 | |3;audio-fft;81;58;59;89;51;62;73;82;106;60 17:07:31 INFO - PROCESS | 1660 | |4;audio-oscillator;87;56;93;68;67;82;71;71;87;99 17:07:31 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;114;89;92;86;79;123;95;133;78;101 17:07:31 INFO - PROCESS | 1660 | |6;imaging-darkroom;98;157;124;94;127;134;154;117;155;129 17:07:31 INFO - PROCESS | 1660 | |7;imaging-desaturate;112;144;110;135;137;98;146;74;75;127 17:07:31 INFO - PROCESS | 1660 | |8;json-parse-financial;58;62;69;83;98;88;62;61;61;61 17:07:31 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;74;73;94;67;79;99;103;103;93 17:07:31 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;83;84;85;83;83;85;86;84;84;83 17:07:31 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;133;130;129;136;141;139;184;158;206;163 17:07:31 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;166;162;162;161;162;200;168;163;162;163 17:07:31 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;67;68;68;68;67;67;65;66;68;72 17:07:31 INFO - PROCESS | 1660 | __end_tp_report 17:07:31 INFO - PROCESS | 1660 | __start_cc_report 17:07:31 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,962 17:07:31 INFO - PROCESS | 1660 | __end_cc_report 17:07:31 INFO - PROCESS | 1660 | __startTimestamp1488244051983__endTimestamp 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | ------- Summary: start ------- 17:07:31 INFO - PROCESS | 1660 | Number of tests: 14 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:134.90 Median:135.00 stddev:24.47 (18.1%) stddev-sans-first:24.84 17:07:31 INFO - PROCESS | 1660 | Values: 155.0 140.0 117.0 109.0 174.0 173.0 130.0 117.0 117.0 117.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:111.50 stddev:17.33 (15.5%) stddev-sans-first:14.47 17:07:31 INFO - PROCESS | 1660 | Values: 151.0 105.0 111.0 143.0 110.0 112.0 111.0 111.0 142.0 110.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:210.10 Median:199.00 stddev:31.24 (15.7%) stddev-sans-first:32.38 17:07:31 INFO - PROCESS | 1660 | Values: 229.0 293.0 195.0 194.0 196.0 199.0 199.0 193.0 211.0 192.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:72.10 Median:67.50 stddev:17.25 (25.6%) stddev-sans-first:17.99 17:07:31 INFO - PROCESS | 1660 | Values: 81.0 58.0 59.0 89.0 51.0 62.0 73.0 82.0 106.0 60.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:84.50 stddev:13.53 (16.0%) stddev-sans-first:13.96 17:07:31 INFO - PROCESS | 1660 | Values: 87.0 56.0 93.0 68.0 67.0 82.0 71.0 71.0 87.0 99.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:82.50 stddev:18.67 (22.6%) stddev-sans-first:18.99 17:07:31 INFO - PROCESS | 1660 | Values: 114.0 89.0 92.0 86.0 79.0 123.0 95.0 133.0 78.0 101.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:128.90 Median:154.50 stddev:22.28 (14.4%) stddev-sans-first:20.64 17:07:31 INFO - PROCESS | 1660 | Values: 98.0 157.0 124.0 94.0 127.0 134.0 154.0 117.0 155.0 129.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:115.80 Median:145.00 stddev:26.72 (18.4%) stddev-sans-first:28.31 17:07:31 INFO - PROCESS | 1660 | Values: 112.0 144.0 110.0 135.0 137.0 98.0 146.0 74.0 75.0 127.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:65.50 stddev:14.11 (21.5%) stddev-sans-first:14.25 17:07:31 INFO - PROCESS | 1660 | Values: 58.0 62.0 69.0 83.0 98.0 88.0 62.0 61.0 61.0 61.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:85.40 Median:76.50 stddev:14.41 (18.8%) stddev-sans-first:14.01 17:07:31 INFO - PROCESS | 1660 | Values: 69.0 74.0 73.0 94.0 67.0 79.0 99.0 103.0 103.0 93.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:1.05 (1.3%) stddev-sans-first:1.05 17:07:31 INFO - PROCESS | 1660 | Values: 83.0 84.0 85.0 83.0 83.0 85.0 86.0 84.0 84.0 83.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:149.50 stddev:25.86 (17.3%) stddev-sans-first:26.50 17:07:31 INFO - PROCESS | 1660 | Values: 133.0 130.0 129.0 136.0 141.0 139.0 184.0 158.0 206.0 163.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:163.00 stddev:11.83 (7.3%) stddev-sans-first:12.54 17:07:31 INFO - PROCESS | 1660 | Values: 166.0 162.0 162.0 161.0 162.0 200.0 168.0 163.0 162.0 163.0 17:07:31 INFO - PROCESS | 1660 | 17:07:31 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.94 17:07:31 INFO - PROCESS | 1660 | Values: 67.0 68.0 68.0 68.0 67.0 67.0 65.0 66.0 68.0 72.0 17:07:31 INFO - PROCESS | 1660 | -------- Summary: end -------- 17:07:31 INFO - PROCESS | 1660 | 17:07:32 INFO - TEST-INFO | 1660: exit 0 17:07:32 INFO - TEST-OK | kraken | took 61209ms 17:07:32 INFO - SUITE-END | took 1177s 17:07:33 INFO - Completed test suite (00:19:37) 17:07:33 INFO - javascript benchmark 17:07:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7269.317462466004, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3505.2288496530764, 3589.4615807628834, 3592.9101772455683, 3601.36976029195, 3630.1106228973904, 5311.362636483617, 5431.348238211411, 5891.941080589193, 5965.821025369235, 6014.969925150368, 5970.8805823883495, 6044.9697751511185, 6059.848503787408, 6065.21152250208, 6068.453839154476, 5364.329458817648, 5387.299651045359, 5393.757280922348, 5420.186971954218, 5506.119020956648, 5464.0, 5468.72656367182, 5494.752736126864, 5499.917501237484, 5510.283663123788, 5298.23175639532, 5301.575873930076, 5471.0, 5487.176923461473, 5533.667979921198, 5368.731563421813, 5394.757235924393, 5407.945920540823, 5411.621186516945, 5433.347998240197, 5281.524662780368, 5346.572274218053, 5354.437784032699, 5358.839234822962, 5387.272718183034, 5679.943200567983, 5973.761049558012, 5975.940240597582, 6013.669248191348, 6028.96985515074, 5766.279215098113, 6113.052476866093, 6187.8143655689955, 6187.845303867394, 6217.96891015542, 6301.7164227609865, 6364.1408409865, 6366.236051673783, 6373.776917807901, 6406.679666016727, 6000.36996115406, 6000.879982400327, 6021.849453763691, 6024.1566180734735, 6047.5766696331275, 6236.158118653923, 6351.904721429182, 6498.9350106498805, 6516.869662606721, 6542.803715888531, 6146.678464130144, 6158.907616385758, 6202.472789812917, 6210.285817130997, 6256.874862502725, 6325.272593651789, 6326.430621244018, 6389.7763578274535, 6390.360963903572, 6397.296297407282, 6180.752769889244, 6299.401556852092, 6316.873662526724, 6320.462760665303, 6326.0, 6125.235451818339, 6192.473639740582, 6238.594491358047, 6253.437190652863, 6286.49708023357, 5122.769475373617, 5134.589232861362, 5136.43499215086, 5137.306463627438, 5157.252198431206, 3754.2866855297407, 4507.842225522091, 4542.227821270392, 4593.770311484413, 4601.746903920316, 5689.68706721126, 6069.453749162597, 6102.69486525672, 6144.047672610753, 6193.442590166816, 5454.863628409242, 5966.940330596725, 6395.584287021329, 6398.424141827258, 6464.095026696266, 5999.520038396918, 6062.42406971337, 6150.876982460326, 6160.845978850475, 6201.6899155042065, 4512.819487220474, 5587.636803607834, 5636.887262254732, 5654.180143879114, 5684.062129748628, 6560.770373036921, 6568.901466477911, 6610.239822420387, 6615.338466153346, 6636.43590294811, 6195.938040619536, 6234.438900498795, 6350.7142178603, 6382.68086595659, 6398.48812095022, 5159.432462429205, 5829.621074630136, 6131.804871721949, 6476.902846457401, 6488.0, 5240.502152295526, 6320.5575609706875, 6328.746850125944, 6338.049292606146, 6353.777617783356, 6164.47601953839, 6387.680615969276, 6396.0, 6419.646919419477, 6434.710438030394, 6071.574989750675, 6144.801763656044, 6222.782202622887, 6241.625502469867, 6267.2792628848265, 6221.377862213923, 6246.718897649525, 6254.405831446005, 6273.874522509615, 6309.274433440213, 6162.506999440124, 6223.875522489616, 6242.563020588515, 6265.27949285838, 6279.654618995999, 6134.222293197161, 6148.893199224004, 6202.162708034538, 6212.751489940351, 6224.470919971853, 6213.316535181217, 6222.875542489215, 6225.533085018551, 6231.657258850807, 6245.968770156302], "value": 5843.162894751597, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.2884058765212, 468.723453162634, 481.4848112519601, 502.5150729545988, 545.3946119807014, 40076.19847603046, 41887.79056104723, 41893.371599426, 43738.78130609351, 43772.34341484872, 43546.56453435465, 43812.780936095354, 43977.56022439775, 44008.559914400845, 44029.33955990655, 9524.571394287257, 9671.854922176173, 9734.902650973507, 9740.707778766648, 9809.215262778996, 8975.281977441822, 9027.503487308195, 9055.818883622323, 9077.046910074447, 9079.137481939239, 9065.22945549629, 9075.319351048665, 9083.0, 9103.63585456581, 9105.453672779622, 9048.004719480885, 9054.0, 9098.77253068672, 9117.726468205965, 9123.680671176477, 9675.274354423447, 9739.366941148803, 9753.609855605768, 9763.316567840255, 9771.853422198672, 40972.795136024426, 41021.589784102376, 41310.586894130975, 41456.79271603653, 41476.79261603673, 3268.7711860169798, 3635.054885729703, 3752.8686495972784, 3812.1994381179984, 3813.771173729585, 26541.73458265412, 30055.098347049625, 30312.69687303143, 31689.841550792098, 31951.680483195334, 3278.098522906196, 3298.4062868683627, 3375.902831579722, 3417.3848707232687, 3418.8119653419053, 356650.0, 357974.9999999974, 361976.0, 362043.0, 362212.18893905624, 60612.18163455103, 60756.0, 60796.0, 60975.39024609697, 60982.39017609856, 61740.69129654323, 62118.68940655268, 64159.0, 64194.716105677624, 64361.35638643554, 16689.582760431087, 16721.414750483676, 16922.15389230558, 16933.661326773396, 17011.829881701025, 12623.179493332904, 13009.284489352987, 13045.608631741063, 13053.955683545293, 13065.281409522377, 16958.23687934046, 16967.83032169687, 17047.977121372758, 17080.0, 17099.23053462597, 6949.339812717783, 6978.302169782981, 7011.8597628047155, 7016.929830701628, 7085.610291434021, 846.4032856835915, 936.9531523423801, 970.5729479029204, 997.1125698128672, 1031.0514326819343, 24142.03431862706, 27809.0, 29360.559591606143, 30149.698503015126, 30579.847100764353, 839.7312859884778, 1006.4917216805612, 1026.5431882812077, 1049.5854137615752, 1095.7917995580815, 12811.871881281255, 14370.640733981734, 15119.017263877813, 15474.22628868552, 16379.771517136263, 626266.0, 658569.0, 658985.0, 662753.0, 665397.0, 53056.67358316073, 58615.70692146512, 59357.70321148367, 59447.702761486784, 59594.51013724605, 1335.2856221921224, 1358.7554240236852, 1375.40170026037, 1383.0456984680739, 1385.217352196006, 29448.852755736083, 30233.69766302397, 30516.08451746451, 30742.385152297276, 30926.22684432907, 54460.72769636127, 58256.708716456145, 58415.0, 58424.4157558436, 58499.4150058511, 587404.0, 588225.0, 594840.0, 595292.0, 595600.0, 26835.389876607467, 27024.864875675496, 27151.321216969733, 27180.864095679393, 27214.72785272201, 47321.76339118282, 47724.284135738686, 48507.0, 48807.0, 49189.262161066894, 31924.6807531931, 37262.81368593248, 37376.62623373731, 38956.02609934774, 38958.80520597379, 31912.840435797672, 38658.2268354637, 38797.642082526974, 39533.40699889446, 39988.0, 38255.61744382632, 38483.615163848, 39127.0, 39137.0, 40351.59648403478, 30944.0, 32926.34147316992, 34303.4854477178, 35013.94958151259, 35035.29929401448, 25491.36271593225, 25581.23256302314, 25853.741462585134, 25901.35246618774, 26179.738202618493], "value": 19803.15771528423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.27987625367996, 382.16306289226594, 391.1102242398544, 397.6381492841515, 412.77503760450554, 17923.283068677236, 20023.699644505345, 20624.99999999998, 20786.792132078674, 20874.89562552187, 19097.14062867171, 19528.21887124513, 19808.0, 20057.29799457019, 20290.188392464283, 5715.628484148538, 5799.304083509985, 5871.765129394819, 5873.85315367115, 5983.760649574012, 5689.886202275973, 5785.27684039495, 5940.821775346746, 5943.910841337383, 5945.821625351246, 6106.328303886569, 6142.416470435302, 6147.907781383283, 6179.536534759888, 6182.103594978726, 5864.325602555697, 6141.631502109843, 6169.074638804171, 6176.320604733476, 6208.379162083756, 6023.277206735176, 6034.939650603482, 6041.1240370146525, 6046.879062418771, 6064.848378790522, 13190.4064317105, 13279.601611951657, 13521.459141634323, 13572.389242484112, 13616.114952528153, 2030.2082187946712, 2176.379731776436, 2239.3505883293824, 2299.586074506588, 2522.9116980905765, 8945.821083578292, 9369.76575585609, 10039.799204015952, 10584.470776461147, 10607.15142788575, 1775.112443778111, 1784.643071385728, 1897.8007309232607, 1909.9427017189369, 1942.417274817549, 117807.8219217814, 119330.40334798358, 121568.0, 123722.0, 123941.0, 10158.39049657023, 10976.506057227443, 11784.764304713857, 11808.88191118095, 12022.519099235933, 14810.925945370203, 14867.553973380816, 14870.70258594822, 14892.329845156994, 14919.328630211667, 8374.874376884352, 8618.0, 8649.0, 8717.869231961526, 8814.735557933273, 8584.0, 8607.48355098696, 8625.870611940825, 8752.993405758292, 8768.430052046597, 4499.977500112478, 4561.749103799323, 4580.610648094883, 4644.256918892961, 4670.182718024332, 1590.403598650506, 1652.900825950447, 1899.705545640428, 1949.6198241343086, 1959.0302800114034, 752.9849403012018, 874.6486678082377, 929.2983797233181, 966.8839739231337, 1029.9485025748684, 20063.799362006484, 20940.057697403652, 21016.789832101484, 21131.8943405282, 21187.78812211889, 851.9148085191431, 898.9775255618662, 917.3624331089828, 965.7537327981461, 980.4803454169302, 6773.729050837911, 10569.682909512727, 11126.38804865724, 11127.554897804159, 11180.496877640526, 578068.0, 580013.0999344976, 609774.0, 617403.0, 620542.0, 133907.0, 145037.0, 146557.0, 148919.0, 149591.0, 845.9383473740417, 933.2300851797295, 971.2909576009553, 1003.5734812704571, 1011.7723512209694, 18338.899666020083, 18672.0, 19016.0, 19186.712199316742, 19462.416127516197, 52784.20823687571, 53268.73365633147, 54125.72937135289, 55635.0, 58227.4177258222, 60597.0, 73762.89355659562, 76046.0, 80809.78785318107, 81401.3719725614, 7908.446408751563, 11674.70813229676, 12174.75650487003, 12314.75370492603, 12956.416961236955, 13033.804492932803, 13534.526291579747, 13766.449342026206, 13805.585832425044, 14104.36530356157, 9352.67265645699, 11611.361375124448, 11852.644420667393, 11910.404479776149, 12245.877541224474, 11637.53449861996, 11789.351585662871, 11803.0, 11865.228760130563, 12124.636260912186, 11897.107716921093, 11898.643040708792, 12121.818172727593, 12154.209976351509, 12309.44607492683, 12584.244945303311, 12708.173968692005, 12783.23300601967, 12981.480740770641, 13084.018698597452, 11847.644570662895, 11881.524739010689, 12189.024878009915, 12194.51221951112, 12221.511139554319], "value": 9737.398210455729, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.1895947749, 1495.8205015398155, 1681.730923052312, 1793.461961411576, 1831.8534517238622, 7996.400269979753, 8197.672093116269, 8402.747917562476, 8460.32317414606, 8483.36374771893, 8322.501949649077, 8450.98588169419, 8462.788430289245, 8483.872741908861, 8491.575421228945, 2356.163561935514, 2370.383700237933, 2372.193454225563, 2373.821963352747, 2387.832851700373, 2364.798992085666, 2393.5212957408503, 2394.1022116706235, 2403.8317317787673, 2410.2648692148887, 2083.906224219906, 2319.585053117597, 2348.5420343033115, 2357.1867705641525, 2386.916457923973, 2326.7207935047904, 2332.3352844439337, 2355.057976809273, 2360.929172124839, 2373.442241073355, 1997.8801271923585, 2370.9051637934463, 2387.8089752819733, 2391.940201494959, 2399.9520009599887, 8390.03514595817, 8460.788480288042, 8478.872816907751, 8511.191436813555, 8526.360522960802, 4810.158222311082, 5057.367829021372, 5065.1642478990925, 5111.258867464197, 5240.187770895517, 2803.4112836304403, 3424.6746559076846, 3497.667721566447, 3510.1926556891804, 3558.804265765382, 999.115782532464, 1028.275066078413, 1079.7192729890207, 1087.6193332333698, 1090.8145615245428, 10726.678199654023, 10769.299995500267, 10829.241953063289, 10854.78290434187, 10935.453227338681, 4275.657947364203, 4440.800163992628, 4523.072770082125, 4536.931946020813, 4537.500874903758, 8663.48019118855, 8683.044865064838, 8689.435186712843, 8715.259202967818, 8717.782055448664, 5121.820736274287, 5127.79488820443, 5142.0744266031725, 5162.1224391853475, 5238.7904483820985, 3779.829907654162, 3962.881113566598, 4154.1068670236045, 4740.265258884879, 4775.0, 3249.821259830732, 3599.9640003600152, 3679.19057807282, 3752.380857158593, 3807.9428808567895, 1144.7481554058095, 1152.472973310367, 1156.9768604627861, 1158.449736375215, 1161.9825702614467, 867.4101610904645, 876.9035406105323, 900.8288425199191, 909.663424532927, 921.4102974096584, 5623.072193088176, 5704.458076482728, 5706.9429305707245, 5769.865149894482, 5921.644701317935, 846.2975730143966, 906.2342320738965, 929.9116583924516, 959.0553304994575, 990.5443495991781, 3845.1732877431486, 3886.8639597613947, 3901.3757798752063, 3934.7639141651593, 3941.7832019239218, 9855.507224638883, 10198.694039178836, 10203.979602039884, 10206.387616743019, 10216.795664086676, 10070.345427547187, 10075.445850478294, 10101.69694909154, 10120.443375614264, 10125.341852779546, 7512.286332798375, 7808.492447990862, 7855.0, 7856.0, 7956.761297161094, 5721.942780572141, 5842.503387212135, 5846.883062338815, 5862.179294898803, 5981.700914954322, 9072.410293330913, 9283.257339412696, 9344.719658410258, 9427.387219830689, 9445.0, 9198.724038278862, 9352.205062569758, 9454.480003599869, 9531.714048578553, 9643.373180743229, 5963.582549221513, 7096.822579435556, 7131.0, 7193.4604904631315, 7280.271972802678, 7937.40469464804, 8005.519668819889, 8011.479253848481, 8037.23646253605, 8037.7588672339925, 7018.719251229893, 7130.037444945074, 7145.785626431215, 7211.42308615299, 7239.746608868664, 6967.229473516179, 7058.0, 7067.6819543119655, 7131.0, 7176.06711127571, 6689.063531105552, 6697.799066028027, 6760.222574404006, 6797.6941037654415, 6902.827429314308, 4805.351277577623, 4839.1531481989805, 4857.101436234308, 4870.586000189882, 4935.580475659609, 4717.268823332389, 4774.3315935769715, 4782.33047373361, 4871.780769865435, 4879.658423910292], "value": 4414.736763373218, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.62687610469237, 313.4811886328128, 322.7547064231184, 325.9217787730945, 326.54936188060475, 5290.836016076457, 5389.461053894609, 5482.889087701234, 5490.7529161187795, 5526.502614764676, 5234.0, 5330.866728331794, 5419.783208671648, 5429.837104886859, 5440.095966411764, 4147.817871906507, 4170.833166673329, 4171.519110715698, 4174.97912510437, 4178.895527611804, 3641.362761516724, 3810.333191691443, 4088.7955602219918, 4143.274926887798, 4184.225918205127, 3679.374506333916, 3686.6313368663186, 3898.927794856423, 4046.433499310099, 4122.97938510307, 3871.547720121854, 3978.7214894957365, 4080.571539988303, 4089.6114869087387, 4120.979395103035, 3388.7797293175863, 3491.389006923778, 3515.3145136698354, 3516.929661406783, 3552.520409744703, 5187.533122019036, 5247.317848679685, 5261.344055140739, 5280.841574752763, 5287.841364759025, 4026.1545075534173, 4660.906781864378, 4676.321933319649, 4682.859514214579, 4702.717836929795, 5332.706701131437, 5490.8153271102665, 5556.277683901067, 5594.58040646949, 5597.020521408737, 3865.2849222893856, 3894.785786781726, 3903.473031140788, 3904.941425878614, 3916.941245881314, 4915.5330243626795, 5702.771889124471, 5782.421757824226, 6013.488853447462, 6022.367651396584, 3512.332656795201, 3670.5778835433734, 3709.536307961505, 3773.339665558516, 3952.980235098806, 3040.9239769005953, 3367.562216911786, 3521.876734314338, 3947.2500224957166, 3995.320795464778, 4162.812673429703, 4383.62739167168, 4649.837255696035, 4660.557247061523, 4661.743604101739, 4704.95295047052, 5083.389993200765, 5373.2746079278795, 5696.82909512707, 5712.200291959129, 1270.4791035675328, 1276.5149243287676, 1310.5020092364841, 1316.8214448068925, 1320.221069568959, 760.68811787167, 762.9389648828192, 804.4730701390598, 819.418213068716, 829.6847198064697, 5100.719460429712, 5125.513076257749, 5247.921281180786, 5251.343582052244, 5253.791627925599, 4567.474740404829, 5054.671446355975, 5565.41563135873, 5655.293088363955, 5703.3764468345025, 4993.0, 5190.923630547735, 5192.170267204383, 5204.9219261711105, 5240.737963101829, 2658.441727237263, 2779.9722002779713, 2794.455081259135, 2955.1825627239095, 2956.5712971618996, 5008.974955125201, 5789.3921138279875, 5798.797042103506, 5800.274965629296, 5820.738066787005, 4609.677322587454, 5145.044882944457, 5725.454127385583, 5747.850429914034, 5785.739641716133, 4726.409198850144, 5378.0, 5832.329282132524, 5835.336928975222, 5870.5010074144175, 4906.116898958079, 5561.610687252015, 5615.945648916008, 5630.521405680399, 5642.322921249476, 4735.976320118378, 4774.832880849292, 5534.667919924817, 5539.002979463574, 5573.5819813513335, 4829.864981729361, 4842.716680079852, 5203.869903252297, 5276.868078298074, 5333.7333133343955, 3011.623547056618, 3183.872645094263, 3625.619309972415, 3736.9626303736613, 3926.290859307069, 4927.630427717864, 5210.557102646318, 5247.5539579134675, 5438.374586922397, 5850.678212698343, 4977.590350609844, 5002.674826136289, 5709.628874123168, 5725.227094342377, 5726.828195154152, 4579.335996280587, 5109.748111712505, 5461.86987075049, 5645.887082258414, 5670.631408958405, 5406.972965135306, 5528.917066243929, 5530.889382212253, 5566.832995010156, 5626.35296940857, 4257.6168144867115, 5665.150227465913, 5683.60214784961, 5698.430156984268, 5701.6864072474755, 4160.91678166441, 4497.527759585197, 4625.606823420047, 5262.842114736411, 5743.8851222976145], "value": 4028.8217384852032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.8751024815534, 704.3766266853835, 761.8590560746259, 766.7661363284196, 782.1357400072922, 12570.874291257085, 13150.736985260313, 14226.288685565733, 15261.0, 15300.234988250584, 14507.129572225675, 14828.406863725439, 15069.246537673127, 15205.619859503518, 15446.768298475503, 857.6226460357439, 868.4919322196523, 873.458455757428, 873.7509809704236, 873.829603227371, 853.5817449449756, 882.0738224863867, 886.0607755778894, 887.40987243483, 887.5473508510673, 888.3958907942597, 900.7252787899688, 930.7905721212707, 935.6678379175397, 935.8034812689343, 897.5422534507383, 924.1543987251657, 929.2844509727539, 931.5807886451124, 932.3846261467432, 694.2432748304323, 695.0824911117327, 696.7979286007052, 697.052009267396, 698.3156506623537, 11727.7068073298, 13893.513727019606, 14551.70896582073, 14594.927025364912, 14651.0, 13452.798208026887, 13682.247476388795, 13689.247091409969, 13777.586672399844, 13862.376193071335, 11006.174536909684, 11140.721481962935, 11146.164037697205, 11446.255993360404, 12029.639110826689, 3571.2678900825267, 3657.1588534636917, 3761.586225515191, 3861.6331448512346, 3895.9610403896163, 68268.6586567069, 95784.0, 95790.52104739432, 98675.0, 99197.0, 10503.842442363371, 10592.15262778976, 10702.250842440955, 10705.250632455809, 10737.731556711145, 19591.608167836563, 21070.47323816917, 21143.365699029055, 21164.682529762067, 21189.15243390278, 7026.229068189564, 7978.920210797934, 7997.400194985399, 8016.0, 8065.7176998805935, 4231.957680423218, 4303.117860838521, 4401.559844015573, 4425.35832304314, 4444.0, 3405.523226748257, 3534.0634731796094, 3585.462180672868, 3590.2101537661674, 3590.281943611236, 679.2799632389683, 682.9795106146823, 690.2821066091209, 693.6947742993067, 725.4341613541446, 583.3175185033521, 633.7971849008366, 636.4303947966637, 655.4985436141355, 661.9743584631044, 7795.064592248853, 9012.81974360509, 9485.478298693639, 9514.096160864707, 9584.616615335308, 524.2607922828793, 528.9788408463695, 529.3462573721451, 552.7181137619842, 580.8373655376502, 4125.658073605414, 4161.8335266589, 4164.75011499311, 4374.103308821747, 4388.846390376321, 104248.0, 115371.0, 119441.0, 119865.0, 124130.0, 76052.23947760562, 77217.6139119312, 79547.60226198832, 82080.58959705163, 85222.57388713141, 56587.0, 71453.0, 73051.0, 74605.25394745983, 76584.23415765772, 9539.0, 9549.856752148862, 9679.128878400978, 9705.223582113555, 9719.514024298898, 45910.0, 47518.5248147528, 48353.5164648349, 50815.237771432716, 51356.0, 72931.27068729245, 75828.62085689757, 76253.23746762684, 76595.0, 81769.0, 12532.122751407314, 12668.683282918, 12960.740785184433, 13127.212367257995, 13302.068855180045, 13971.510997115052, 14266.215358155401, 14289.857101428852, 14454.927725361727, 14496.927515362777, 13123.737525249251, 13175.934120329337, 13430.127041742646, 13548.458061677817, 13613.251271179784, 12892.484300628244, 12945.288009159587, 13387.263700496176, 13556.93221533886, 13907.58277251684, 12667.80998285045, 13241.602751917459, 13273.203607783564, 13513.324333783468, 13691.520796772065, 10418.374897506174, 10693.732656683645, 10769.438296554416, 11074.28017178913, 11332.263402878787, 9981.251406144713, 10986.780264394507, 11252.324860508395, 11551.826722599335, 11563.248388854698], "value": 7362.1732767665335, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1585.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 140.0, 117.0, 109.0, 174.0, 173.0, 130.0, 117.0, 117.0, 117.0], "value": 134.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 105.0, 111.0, 143.0, 110.0, 112.0, 111.0, 111.0, 142.0, 110.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 293.0, 195.0, 194.0, 196.0, 199.0, 199.0, 193.0, 211.0, 192.0], "value": 210.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 59.0, 89.0, 51.0, 62.0, 73.0, 82.0, 106.0, 60.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 56.0, 93.0, 68.0, 67.0, 82.0, 71.0, 71.0, 87.0, 99.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 89.0, 92.0, 86.0, 79.0, 123.0, 95.0, 133.0, 78.0, 101.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 157.0, 124.0, 94.0, 127.0, 134.0, 154.0, 117.0, 155.0, 129.0], "value": 128.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 144.0, 110.0, 135.0, 137.0, 98.0, 146.0, 74.0, 75.0, 127.0], "value": 115.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 69.0, 83.0, 98.0, 88.0, 62.0, 61.0, 61.0, 61.0], "value": 70.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 74.0, 73.0, 94.0, 67.0, 79.0, 99.0, 103.0, 103.0, 93.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 83.0, 83.0, 85.0, 86.0, 84.0, 84.0, 83.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 129.0, 136.0, 141.0, 139.0, 184.0, 158.0, 206.0, 163.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 161.0, 162.0, 200.0, 168.0, 163.0, 162.0, 163.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 67.0, 65.0, 66.0, 68.0, 72.0], "value": 67.6, "unit": "score"}]}]} 17:07:33 INFO - Return code: 0 17:07:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:07:33 ERROR - # TBPL SUCCESS # 17:07:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:07:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:07:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:07:33 INFO - 2017-02-27 17:07:33.286 screenresolution[1665:13824] starting screenresolution argv=screenresolution get 17:07:33 INFO - 2017-02-27 17:07:33.290 screenresolution[1665:13824] Display 0: 1600x1200x32@60 17:07:33 INFO - 2017-02-27 17:07:33.296 screenresolution[1666:13827] starting screenresolution argv=screenresolution list 17:07:33 INFO - Available Modes on Display 0 17:07:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:07:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:07:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:07:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:07:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:07:33 INFO - Intel Iris: 17:07:33 INFO - Chipset Model: Intel Iris 17:07:33 INFO - Type: GPU 17:07:33 INFO - Bus: Built-In 17:07:33 INFO - VRAM (Dynamic, Max): 1536 MB 17:07:33 INFO - Vendor: Intel (0x8086) 17:07:33 INFO - Device ID: 0x0a2e 17:07:33 INFO - Revision ID: 0x0009 17:07:33 INFO - Displays: 17:07:33 INFO - Display: 17:07:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:07:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:07:33 INFO - Display Serial Number: 1600x1200 60 17:07:33 INFO - Main Display: Yes 17:07:33 INFO - Mirror: Off 17:07:33 INFO - Online: Yes 17:07:33 INFO - Rotation: Supported 17:07:33 INFO - Return code: 0 17:07:33 INFO - Running post-action listener: _resource_record_post_action 17:07:33 INFO - [mozharness: 2017-02-28 01:07:33.537318Z] Finished run-tests step (success) 17:07:33 INFO - Running post-run listener: _resource_record_post_run 17:07:33 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 35057664; Write bytes: 505313280; Read time: 380; Write time: 1855 17:07:33 INFO - TinderboxPrint: CPU usage
54.3% 17:07:33 INFO - TinderboxPrint: I/O read bytes / time
35,057,664 / 380 17:07:33 INFO - TinderboxPrint: I/O write bytes / time
505,313,280 / 1,855 17:07:33 INFO - TinderboxPrint: CPU idle
2,191.9 (45.7%) 17:07:33 INFO - TinderboxPrint: CPU system
969.1 (20.2%) 17:07:33 INFO - TinderboxPrint: CPU user
1,636.8 (34.1%) 17:07:33 INFO - TinderboxPrint: Swap in / out
222,769,152 / 0 17:07:33 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 187945472; Write bytes: 188553216; Read time: 17022; Write time: 404 17:07:33 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 33124352; Write bytes: 309800960; Read time: 303; Write time: 1423 17:07:34 INFO - Running post-run listener: _upload_blobber_files 17:07:34 INFO - Blob upload gear active. 17:07:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:07:34 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 17:07:34 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:07:34 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:07:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:35 INFO - (blobuploader) - INFO - Done attempting. 17:07:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:07:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:07:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:36 INFO - (blobuploader) - INFO - Done attempting. 17:07:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:07:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:07:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:07:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:07:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:07:39 INFO - (blobuploader) - INFO - Done attempting. 17:07:39 INFO - (blobuploader) - INFO - Iteration through files over. 17:07:39 INFO - Return code: 0 17:07:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:07:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:07:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5b3255130219c3cf66113bc731ba020aae9252293340fa41f67da9ad07b3e681518dfa6983e07151185e83f012d11edc35255263cf84162c5cba1439ed041c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/438d3b4e25545baf75da0d2dfd17b7ed63b40ed485072d91d83c6ff2215871c5b8ed9eb8f293cbc1536f84bfaf87331c14835337475e23ea31907cf3b490b68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62917b90413a68bcade4bf28a741363a83a99d8aa8f16a6acb53621a82d9c5622c8b5be21a185ed58e72e0a797be35132fd7581ce40fd85e721f79c24af6bf99"} 17:07:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:07:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:07:39 INFO - Contents: 17:07:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5b3255130219c3cf66113bc731ba020aae9252293340fa41f67da9ad07b3e681518dfa6983e07151185e83f012d11edc35255263cf84162c5cba1439ed041c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/438d3b4e25545baf75da0d2dfd17b7ed63b40ed485072d91d83c6ff2215871c5b8ed9eb8f293cbc1536f84bfaf87331c14835337475e23ea31907cf3b490b68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62917b90413a68bcade4bf28a741363a83a99d8aa8f16a6acb53621a82d9c5622c8b5be21a185ed58e72e0a797be35132fd7581ce40fd85e721f79c24af6bf99"} 17:07:39 INFO - Running post-run listener: copy_logs_to_upload_dir 17:07:39 INFO - Copying logs to upload dir... 17:07:39 INFO - mkdir: /builds/slave/test/build/upload/logs 17:07:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.243394 ========= master_lag: 0.29 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-27 17:07:39.672602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 17:07:39.675714) ========= 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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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-Beta/sha512/c5b3255130219c3cf66113bc731ba020aae9252293340fa41f67da9ad07b3e681518dfa6983e07151185e83f012d11edc35255263cf84162c5cba1439ed041c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/438d3b4e25545baf75da0d2dfd17b7ed63b40ed485072d91d83c6ff2215871c5b8ed9eb8f293cbc1536f84bfaf87331c14835337475e23ea31907cf3b490b68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62917b90413a68bcade4bf28a741363a83a99d8aa8f16a6acb53621a82d9c5622c8b5be21a185ed58e72e0a797be35132fd7581ce40fd85e721f79c24af6bf99"} build_url:https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010990 build_url: 'https://queue.taskcluster.net/v1/task/LP3c37SLTXC4kvQpbDkLLw/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5b3255130219c3cf66113bc731ba020aae9252293340fa41f67da9ad07b3e681518dfa6983e07151185e83f012d11edc35255263cf84162c5cba1439ed041c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/438d3b4e25545baf75da0d2dfd17b7ed63b40ed485072d91d83c6ff2215871c5b8ed9eb8f293cbc1536f84bfaf87331c14835337475e23ea31907cf3b490b68a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/62917b90413a68bcade4bf28a741363a83a99d8aa8f16a6acb53621a82d9c5622c8b5be21a185ed58e72e0a797be35132fd7581ce40fd85e721f79c24af6bf99"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 17:07:39.709612) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 17:07:39.709929) ========= 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.TG5j0zLRGo/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.gR3eWbuw3V/Listeners TMPDIR=/var/folders/mc/k6pkwgw92536d85s37s4xsc800000w/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.005074 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 17:07:39.757954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 17:07:39.758252) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 17:07:39.758560) ========= ========= Total master_lag: 0.43 =========