builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0073 starttime: 1472740954.31 results: success (0) buildid: 20160901063021 builduid: 454f3ba842cf455db9fe498d68ed76b5 revision: 27ffae997b83a5bfeaf0967e692074cb097d94e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.313795) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.314215) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.314486) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.337696) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.338084) ========= 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.3oP8aOOaED/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.a9MJOVn858/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-01 07:42:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 218M=0s 2016-09-01 07:42:34 (218 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128521 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.490370) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.490693) ========= 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.3oP8aOOaED/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.a9MJOVn858/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.020928 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:34.539410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 07:42:34.539767) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 27ffae997b83a5bfeaf0967e692074cb097d94e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 27ffae997b83a5bfeaf0967e692074cb097d94e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3oP8aOOaED/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.a9MJOVn858/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-01 07:42:34,612 truncating revision to first 12 chars 2016-09-01 07:42:34,612 Setting DEBUG logging. 2016-09-01 07:42:34,612 attempt 1/10 2016-09-01 07:42:34,612 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/27ffae997b83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 07:42:36,173 unpacking tar archive at: fx-team-27ffae997b83/testing/mozharness/ program finished with exit code 0 elapsedTime=1.823930 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-01 07:42:36.386487) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:36.386821) ========= script_repo_revision: 27ffae997b83a5bfeaf0967e692074cb097d94e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:36.387197) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:36.387459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 07:42:36.405937) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2016-09-01 07:42:36.406242) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3oP8aOOaED/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.a9MJOVn858/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:42:36 INFO - MultiFileLogger online at 20160901 07:42:36 in /builds/slave/test 07:42:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:42:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:36 INFO - {'append_to_log': False, 07:42:36 INFO - 'base_work_dir': '/builds/slave/test', 07:42:36 INFO - 'blob_upload_branch': 'Fx-Team', 07:42:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:36 INFO - 'branch': 'Fx-Team', 07:42:36 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:36 INFO - 'config_files': ('talos/mac_config.py',), 07:42:36 INFO - 'default_actions': ('clobber', 07:42:36 INFO - 'read-buildbot-config', 07:42:36 INFO - 'download-and-extract', 07:42:36 INFO - 'populate-webroot', 07:42:36 INFO - 'create-virtualenv', 07:42:36 INFO - 'install', 07:42:36 INFO - 'run-tests'), 07:42:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:36 INFO - 'download_minidump_stackwalk': True, 07:42:36 INFO - 'download_symbols': 'ondemand', 07:42:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:36 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:36 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:36 INFO - 'installer_path': 'installer.exe', 07:42:36 INFO - 'log_level': 'info', 07:42:36 INFO - 'log_name': 'talos', 07:42:36 INFO - 'log_to_console': True, 07:42:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:42:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:42:36 INFO - 'opt_config_files': (), 07:42:36 INFO - 'pip_index': False, 07:42:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:36 INFO - 'cmd': ('bash', 07:42:36 INFO - '-c', 07:42:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:36 INFO - 'enabled': True, 07:42:36 INFO - 'halt_on_failure': False, 07:42:36 INFO - 'name': 'check_screen_resolution'},), 07:42:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:42:36 INFO - 'cmd': ('bash', 07:42:36 INFO - '-c', 07:42:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:42:36 INFO - 'enabled': True, 07:42:36 INFO - 'halt_on_failure': False, 07:42:36 INFO - 'name': 'check_screen_resolution'},), 07:42:36 INFO - 'run_cmd_checks_enabled': True, 07:42:36 INFO - 'sps_profile': False, 07:42:36 INFO - 'sps_profile_interval': 0, 07:42:36 INFO - 'suite': 'dromaeojs', 07:42:36 INFO - 'system_bits': '32', 07:42:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:36 INFO - 'title': 't-yosemite-r7-0073', 07:42:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:36 INFO - 'use_talos_json': True, 07:42:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:36 INFO - 'work_dir': 'build'} 07:42:36 INFO - [mozharness: 2016-09-01 14:42:36.597419Z] Running clobber step. 07:42:36 INFO - Running pre-action listener: _resource_record_pre_action 07:42:36 INFO - Running main action method: clobber 07:42:36 INFO - rmtree: /builds/slave/test/build 07:42:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:38 INFO - Running post-action listener: _resource_record_post_action 07:42:38 INFO - [mozharness: 2016-09-01 14:42:38.575263Z] Finished clobber step (success) 07:42:38 INFO - [mozharness: 2016-09-01 14:42:38.575415Z] Running read-buildbot-config step. 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: read_buildbot_config 07:42:38 INFO - Using buildbot properties: 07:42:38 INFO - { 07:42:38 INFO - "project": "", 07:42:38 INFO - "product": "firefox", 07:42:38 INFO - "script_repo_revision": "production", 07:42:38 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:42:38 INFO - "repository": "", 07:42:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:42:38 INFO - "buildid": "20160901063021", 07:42:38 INFO - "pgo_build": "False", 07:42:38 INFO - "basedir": "/builds/slave/test", 07:42:38 INFO - "buildnumber": 150, 07:42:38 INFO - "slavename": "t-yosemite-r7-0073", 07:42:38 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:42:38 INFO - "platform": "yosemite_r7", 07:42:38 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:42:38 INFO - "branch": "fx-team", 07:42:38 INFO - "repo_path": "integration/fx-team", 07:42:38 INFO - "revision": "27ffae997b83a5bfeaf0967e692074cb097d94e8", 07:42:38 INFO - "stage_platform": "macosx64", 07:42:38 INFO - "builduid": "454f3ba842cf455db9fe498d68ed76b5", 07:42:38 INFO - "slavebuilddir": "test" 07:42:38 INFO - } 07:42:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 07:42:38 INFO - Running post-action listener: _resource_record_post_action 07:42:38 INFO - [mozharness: 2016-09-01 14:42:38.578865Z] Finished read-buildbot-config step (success) 07:42:38 INFO - [mozharness: 2016-09-01 14:42:38.578986Z] Running download-and-extract step. 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: download_and_extract 07:42:38 INFO - mkdir: /builds/slave/test/build/tests 07:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:38 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 07:42:38 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 07:42:39 INFO - Downloaded 1199 bytes. 07:42:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 07:42:39 INFO - Using the following test package requirements: 07:42:39 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:42:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 07:42:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 07:42:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'jsshell-mac.zip'], 07:42:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 07:42:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 07:42:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 07:42:39 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 07:42:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 07:42:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 07:42:39 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 07:42:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:39 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:42:39 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:42:40 INFO - Downloaded 16399864 bytes. 07:42:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:42:47 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:42:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:47 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:42:47 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 07:42:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:42:48 INFO - Downloaded 16399864 bytes. 07:42:48 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 07:42:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:55 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:42:55 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 07:42:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:42:56 INFO - Downloaded 14413998 bytes. 07:42:56 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:56 INFO - trying https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:42:56 INFO - Downloading https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 07:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 07:42:59 INFO - Downloaded 111597574 bytes. 07:42:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:42:59 INFO - mkdir: /builds/slave/test/properties 07:42:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:42:59 INFO - Writing to file /builds/slave/test/properties/build_url 07:42:59 INFO - Contents: 07:42:59 INFO - build_url:https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 07:43:00 INFO - Running post-action listener: _resource_record_post_action 07:43:00 INFO - Running post-action listener: set_extra_try_arguments 07:43:00 INFO - [mozharness: 2016-09-01 14:43:00.070008Z] Finished download-and-extract step (success) 07:43:00 INFO - [mozharness: 2016-09-01 14:43:00.070140Z] Running populate-webroot step. 07:43:00 INFO - Running pre-action listener: _resource_record_pre_action 07:43:00 INFO - Running main action method: populate_webroot 07:43:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:43:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:43:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:43:00 INFO - '--tppagecycles', 07:43:00 INFO - '7'], 07:43:00 INFO - 'tests': ['tsvgm']}}, 07:43:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:43:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:43:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:43:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:43:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:43:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['damp', 'tps']}, 07:43:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'tests': ['damp', 'tps']}, 07:43:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['dromaeo_dom']}, 07:43:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:43:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['basic_compositor_video']}, 07:43:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:43:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['a11yr', 07:43:00 INFO - 'ts_paint', 07:43:00 INFO - 'tpaint', 07:43:00 INFO - 'sessionrestore', 07:43:00 INFO - 'sessionrestore_no_auto_restore', 07:43:00 INFO - 'tabpaint']}, 07:43:00 INFO - 'other-e10s': {'tests': ['a11yr', 07:43:00 INFO - 'ts_paint', 07:43:00 INFO - 'tpaint', 07:43:00 INFO - 'sessionrestore', 07:43:00 INFO - 'sessionrestore_no_auto_restore', 07:43:00 INFO - 'tabpaint']}, 07:43:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:43:00 INFO - 'ts_paint', 07:43:00 INFO - 'tpaint', 07:43:00 INFO - 'sessionrestore', 07:43:00 INFO - 'sessionrestore_no_auto_restore', 07:43:00 INFO - 'tabpaint']}, 07:43:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:43:00 INFO - 'ts_paint', 07:43:00 INFO - 'tpaint', 07:43:00 INFO - 'sessionrestore', 07:43:00 INFO - 'sessionrestore_no_auto_restore', 07:43:00 INFO - 'tabpaint']}, 07:43:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['a11yr', 07:43:00 INFO - 'ts_paint', 07:43:00 INFO - 'tpaint', 07:43:00 INFO - 'sessionrestore', 07:43:00 INFO - 'sessionrestore_no_auto_restore', 07:43:00 INFO - 'tabpaint']}, 07:43:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['a11yr', 07:43:00 INFO - 'ts_paint', 07:43:00 INFO - 'tpaint', 07:43:00 INFO - 'sessionrestore', 07:43:00 INFO - 'sessionrestore_no_auto_restore', 07:43:00 INFO - 'tabpaint']}, 07:43:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['tsvgx', 07:43:00 INFO - 'tsvgr_opacity', 07:43:00 INFO - 'tart', 07:43:00 INFO - 'tscrollx', 07:43:00 INFO - 'cart']}, 07:43:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:43:00 INFO - 'tsvgr_opacity', 07:43:00 INFO - 'tart', 07:43:00 INFO - 'tscrollx', 07:43:00 INFO - 'cart']}, 07:43:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'talos_options': ['--disable-e10s'], 07:43:00 INFO - 'tests': ['tp5o']}, 07:43:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'tests': ['tp5o']}, 07:43:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'talos_options': ['--disable-e10s', 07:43:00 INFO - '--xperf_path', 07:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:00 INFO - 'tests': ['tp5n']}, 07:43:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:43:00 INFO - 'talos_options': ['--xperf_path', 07:43:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:43:00 INFO - 'tests': ['tp5n']}}, 07:43:00 INFO - 'talos.zip': {'path': '', 07:43:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:43:00 INFO - Running post-action listener: _resource_record_post_action 07:43:00 INFO - [mozharness: 2016-09-01 14:43:00.088807Z] Finished populate-webroot step (success) 07:43:00 INFO - [mozharness: 2016-09-01 14:43:00.088945Z] Running create-virtualenv step. 07:43:00 INFO - Running pre-action listener: _resource_record_pre_action 07:43:00 INFO - Running main action method: create_virtualenv 07:43:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:43:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:43:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:43:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:43:00 INFO - Using real prefix '/tools/python27' 07:43:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:43:00 INFO - Installing distribute.............................................................................................................................................................................................done. 07:43:03 INFO - Installing pip.................done. 07:43:03 INFO - Return code: 0 07:43:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:03 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:43:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:43:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:03 INFO - 'HOME': '/Users/cltbld', 07:43:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:03 INFO - 'LOGNAME': 'cltbld', 07:43:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:03 INFO - 'MOZ_NO_REMOTE': '1', 07:43:03 INFO - 'NO_EM_RESTART': '1', 07:43:03 INFO - 'PAGER': '/bin/cat', 07:43:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:03 INFO - 'PWD': '/builds/slave/test', 07:43:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:03 INFO - 'SHELL': '/bin/bash', 07:43:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:03 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:03 INFO - 'USER': 'cltbld', 07:43:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:03 INFO - 'XPC_FLAGS': '0x0', 07:43:03 INFO - 'XPC_SERVICE_NAME': '0', 07:43:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:43:04 INFO - Cleaning up... 07:43:04 INFO - Return code: 0 07:43:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:04 INFO - 'HOME': '/Users/cltbld', 07:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:04 INFO - 'LOGNAME': 'cltbld', 07:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:04 INFO - 'MOZ_NO_REMOTE': '1', 07:43:04 INFO - 'NO_EM_RESTART': '1', 07:43:04 INFO - 'PAGER': '/bin/cat', 07:43:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:04 INFO - 'PWD': '/builds/slave/test', 07:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:04 INFO - 'SHELL': '/bin/bash', 07:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:04 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:04 INFO - 'USER': 'cltbld', 07:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:04 INFO - 'XPC_FLAGS': '0x0', 07:43:04 INFO - 'XPC_SERVICE_NAME': '0', 07:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:04 INFO - Downloading/unpacking psutil>=3.1.1 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:43:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:07 INFO - Installing collected packages: psutil 07:43:07 INFO - Running setup.py install for psutil 07:43:07 INFO - building 'psutil._psutil_osx' extension 07:43:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:43:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:43:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:43:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:43:07 INFO - building 'psutil._psutil_posix' extension 07:43:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:43:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:43:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:43:07 INFO - ^ 07:43:08 INFO - 1 warning generated. 07:43:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:43:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:43:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:43:08 INFO - Successfully installed psutil 07:43:08 INFO - Cleaning up... 07:43:08 INFO - Return code: 0 07:43:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:08 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:43:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:08 INFO - 'HOME': '/Users/cltbld', 07:43:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:08 INFO - 'LOGNAME': 'cltbld', 07:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:08 INFO - 'MOZ_NO_REMOTE': '1', 07:43:08 INFO - 'NO_EM_RESTART': '1', 07:43:08 INFO - 'PAGER': '/bin/cat', 07:43:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:08 INFO - 'PWD': '/builds/slave/test', 07:43:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:08 INFO - 'SHELL': '/bin/bash', 07:43:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:08 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:08 INFO - 'USER': 'cltbld', 07:43:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:08 INFO - 'XPC_FLAGS': '0x0', 07:43:08 INFO - 'XPC_SERVICE_NAME': '0', 07:43:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:43:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:43:11 INFO - Installing collected packages: mozsystemmonitor 07:43:11 INFO - Running setup.py install for mozsystemmonitor 07:43:11 INFO - Successfully installed mozsystemmonitor 07:43:11 INFO - Cleaning up... 07:43:11 INFO - Return code: 0 07:43:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:43:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:43:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:11 INFO - 'HOME': '/Users/cltbld', 07:43:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:11 INFO - 'LOGNAME': 'cltbld', 07:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:11 INFO - 'MOZ_NO_REMOTE': '1', 07:43:11 INFO - 'NO_EM_RESTART': '1', 07:43:11 INFO - 'PAGER': '/bin/cat', 07:43:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:11 INFO - 'PWD': '/builds/slave/test', 07:43:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:11 INFO - 'SHELL': '/bin/bash', 07:43:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:11 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:11 INFO - 'USER': 'cltbld', 07:43:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:11 INFO - 'XPC_FLAGS': '0x0', 07:43:11 INFO - 'XPC_SERVICE_NAME': '0', 07:43:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:11 INFO - Downloading/unpacking jsonschema==2.5.1 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:14 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:14 INFO - warning: no files found matching '*.txt' 07:43:14 INFO - no previously-included directories found matching 'build' 07:43:14 INFO - no previously-included directories found matching 'dist' 07:43:14 INFO - no previously-included directories found matching '.git*' 07:43:14 INFO - Installing collected packages: jsonschema, functools32 07:43:14 INFO - Running setup.py install for functools32 07:43:14 INFO - warning: no files found matching '*.txt' 07:43:14 INFO - no previously-included directories found matching 'build' 07:43:14 INFO - no previously-included directories found matching 'dist' 07:43:14 INFO - no previously-included directories found matching '.git*' 07:43:14 INFO - Successfully installed jsonschema functools32 07:43:14 INFO - Cleaning up... 07:43:14 INFO - Return code: 0 07:43:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:43: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')]} 07:43:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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')]} 07:43:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43: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', '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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:43: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 functools32==3.2.3-2 07:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:14 INFO - 'HOME': '/Users/cltbld', 07:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:14 INFO - 'LOGNAME': 'cltbld', 07:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:14 INFO - 'MOZ_NO_REMOTE': '1', 07:43:14 INFO - 'NO_EM_RESTART': '1', 07:43:14 INFO - 'PAGER': '/bin/cat', 07:43:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:14 INFO - 'PWD': '/builds/slave/test', 07:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:14 INFO - 'SHELL': '/bin/bash', 07:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:14 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:14 INFO - 'USER': 'cltbld', 07:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:14 INFO - 'XPC_FLAGS': '0x0', 07:43:14 INFO - 'XPC_SERVICE_NAME': '0', 07:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:43:15 INFO - Cleaning up... 07:43:15 INFO - Return code: 0 07:43:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:15 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:43:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:43:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:15 INFO - 'HOME': '/Users/cltbld', 07:43:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:15 INFO - 'LOGNAME': 'cltbld', 07:43:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:15 INFO - 'MOZ_NO_REMOTE': '1', 07:43:15 INFO - 'NO_EM_RESTART': '1', 07:43:15 INFO - 'PAGER': '/bin/cat', 07:43:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:15 INFO - 'PWD': '/builds/slave/test', 07:43:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:15 INFO - 'SHELL': '/bin/bash', 07:43:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:15 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:15 INFO - 'USER': 'cltbld', 07:43:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:15 INFO - 'XPC_FLAGS': '0x0', 07:43:15 INFO - 'XPC_SERVICE_NAME': '0', 07:43:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:15 INFO - Downloading/unpacking blobuploader==1.2.4 07:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:17 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:19 INFO - Downloading docopt-0.6.1.tar.gz 07:43:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:19 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:19 INFO - Running setup.py install for blobuploader 07:43:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:19 INFO - Running setup.py install for requests 07:43:19 INFO - Running setup.py install for docopt 07:43:19 INFO - Successfully installed blobuploader requests docopt 07:43:19 INFO - Cleaning up... 07:43:20 INFO - Return code: 0 07:43:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:20 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:43:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:43:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:20 INFO - 'HOME': '/Users/cltbld', 07:43:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:20 INFO - 'LOGNAME': 'cltbld', 07:43:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:20 INFO - 'MOZ_NO_REMOTE': '1', 07:43:20 INFO - 'NO_EM_RESTART': '1', 07:43:20 INFO - 'PAGER': '/bin/cat', 07:43:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:20 INFO - 'PWD': '/builds/slave/test', 07:43:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:20 INFO - 'SHELL': '/bin/bash', 07:43:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:20 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:20 INFO - 'USER': 'cltbld', 07:43:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:20 INFO - 'XPC_FLAGS': '0x0', 07:43:20 INFO - 'XPC_SERVICE_NAME': '0', 07:43:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-_vtLie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-rGa6JY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-K8aqlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-GsjsRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-WoFRKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-N1Qw0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:20 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-NYzUBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Mddnbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-f4ic3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-9kpKq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-A0Z_jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lKgPAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-snPkOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-rF4Ydw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-PYccY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-C3syQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:21 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-sMrRYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:22 INFO - Running setup.py install for manifestparser 07:43:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Running setup.py install for mozcrash 07:43:22 INFO - Running setup.py install for mozdebug 07:43:22 INFO - Running setup.py install for mozdevice 07:43:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Running setup.py install for mozfile 07:43:22 INFO - Running setup.py install for mozhttpd 07:43:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:22 INFO - Running setup.py install for mozinfo 07:43:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Running setup.py install for mozInstall 07:43:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Running setup.py install for mozleak 07:43:23 INFO - Running setup.py install for mozlog 07:43:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Running setup.py install for moznetwork 07:43:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:23 INFO - Running setup.py install for mozprocess 07:43:23 INFO - Running setup.py install for mozprofile 07:43:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:24 INFO - Running setup.py install for mozrunner 07:43:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:24 INFO - Running setup.py install for mozscreenshot 07:43:24 INFO - Running setup.py install for moztest 07:43:24 INFO - Running setup.py install for mozversion 07:43:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:24 INFO - Cleaning up... 07:43:24 INFO - Return code: 0 07:43:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:24 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:43:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:43:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:24 INFO - 'HOME': '/Users/cltbld', 07:43:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:24 INFO - 'LOGNAME': 'cltbld', 07:43:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:24 INFO - 'MOZ_NO_REMOTE': '1', 07:43:24 INFO - 'NO_EM_RESTART': '1', 07:43:24 INFO - 'PAGER': '/bin/cat', 07:43:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:24 INFO - 'PWD': '/builds/slave/test', 07:43:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:24 INFO - 'SHELL': '/bin/bash', 07:43:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:24 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:24 INFO - 'USER': 'cltbld', 07:43:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:24 INFO - 'XPC_FLAGS': '0x0', 07:43:24 INFO - 'XPC_SERVICE_NAME': '0', 07:43:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:24 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-5vR3gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-s22_FU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-NmLO1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-we6M1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-94eJzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-KdhIFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Y9OmvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-j4G_KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-Ox_lca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:43:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:25 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-6i_Vtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-TykI5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-PcWU79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-vXcZNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lQ8GTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-UXvdUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-xHnqHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:43:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:26 INFO - Running setup.py (path:/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/pip-lv_n3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:43:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:43:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:29 INFO - Downloading blessings-1.6.tar.gz 07:43:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:29 INFO - Installing collected packages: blessings 07:43:29 INFO - Running setup.py install for blessings 07:43:29 INFO - Successfully installed blessings 07:43:29 INFO - Cleaning up... 07:43:29 INFO - Return code: 0 07:43:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:29 INFO - Reading from file tmpfile_stdout 07:43:29 INFO - Current package versions: 07:43:29 INFO - blessings == 1.6 07:43:29 INFO - blobuploader == 1.2.4 07:43:29 INFO - docopt == 0.6.1 07:43:29 INFO - functools32 == 3.2.3-2 07:43:29 INFO - jsonschema == 2.5.1 07:43:29 INFO - manifestparser == 1.1 07:43:29 INFO - mozInstall == 1.12 07:43:29 INFO - mozcrash == 0.17 07:43:29 INFO - mozdebug == 0.1 07:43:29 INFO - mozdevice == 0.48 07:43:29 INFO - mozfile == 1.2 07:43:29 INFO - mozhttpd == 0.7 07:43:29 INFO - mozinfo == 0.9 07:43:29 INFO - mozleak == 0.1 07:43:29 INFO - mozlog == 3.3 07:43:29 INFO - moznetwork == 0.27 07:43:29 INFO - mozprocess == 0.23 07:43:29 INFO - mozprofile == 0.28 07:43:29 INFO - mozrunner == 6.12 07:43:29 INFO - mozscreenshot == 0.1 07:43:29 INFO - mozsystemmonitor == 0.3 07:43:29 INFO - moztest == 0.7 07:43:29 INFO - mozversion == 1.4 07:43:29 INFO - psutil == 3.1.1 07:43:29 INFO - requests == 1.2.3 07:43:29 INFO - wsgiref == 0.1.2 07:43:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:29 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:43:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:29 INFO - 'HOME': '/Users/cltbld', 07:43:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:29 INFO - 'LOGNAME': 'cltbld', 07:43:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:29 INFO - 'MOZ_NO_REMOTE': '1', 07:43:29 INFO - 'NO_EM_RESTART': '1', 07:43:29 INFO - 'PAGER': '/bin/cat', 07:43:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:29 INFO - 'PWD': '/builds/slave/test', 07:43:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:29 INFO - 'SHELL': '/bin/bash', 07:43:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:29 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:29 INFO - 'USER': 'cltbld', 07:43:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:29 INFO - 'XPC_FLAGS': '0x0', 07:43:29 INFO - 'XPC_SERVICE_NAME': '0', 07:43:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:43:30 INFO - Cleaning up... 07:43:30 INFO - Return code: 0 07:43:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:43:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:30 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 0x110016a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1100ab618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb6114893c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, '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.3oP8aOOaED/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.a9MJOVn858/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:43:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:43:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:43:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:43:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:43:30 INFO - 'HOME': '/Users/cltbld', 07:43:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:43:30 INFO - 'LOGNAME': 'cltbld', 07:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:30 INFO - 'MOZ_NO_REMOTE': '1', 07:43:30 INFO - 'NO_EM_RESTART': '1', 07:43:30 INFO - 'PAGER': '/bin/cat', 07:43:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:30 INFO - 'PWD': '/builds/slave/test', 07:43:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:43:30 INFO - 'SHELL': '/bin/bash', 07:43:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:43:30 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:43:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:43:30 INFO - 'USER': 'cltbld', 07:43:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:43:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:30 INFO - 'XPC_FLAGS': '0x0', 07:43:30 INFO - 'XPC_SERVICE_NAME': '0', 07:43:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:43:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:43:30 INFO - Cleaning up... 07:43:30 INFO - Return code: 0 07:43:30 INFO - Running post-action listener: _resource_record_post_action 07:43:30 INFO - Running post-action listener: _start_resource_monitoring 07:43:30 INFO - Starting resource monitoring. 07:43:30 INFO - [mozharness: 2016-09-01 14:43:30.391491Z] Finished create-virtualenv step (success) 07:43:30 INFO - [mozharness: 2016-09-01 14:43:30.392598Z] Running install step. 07:43:30 INFO - Running pre-action listener: _resource_record_pre_action 07:43:30 INFO - Running main action method: install 07:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:30 INFO - Reading from file tmpfile_stdout 07:43:30 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:30 INFO - Reading from file tmpfile_stdout 07:43:30 INFO - Output received: 07:43:30 INFO - Usage: mozinstall [options] installer 07:43:30 INFO - Options: 07:43:30 INFO - -h, --help show this help message and exit 07:43:30 INFO - -d DEST, --destination=DEST 07:43:30 INFO - Directory to install application into. [default: 07:43:30 INFO - "/builds/slave/test"] 07:43:30 INFO - --app=APP Application being installed. [default: firefox] 07:43:30 INFO - mkdir: /builds/slave/test/build/application 07:43:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:43:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:44:04 INFO - Reading from file tmpfile_stdout 07:44:04 INFO - Output received: 07:44:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:44:04 INFO - Running post-action listener: _resource_record_post_action 07:44:04 INFO - [mozharness: 2016-09-01 14:44:04.912034Z] Finished install step (success) 07:44:04 INFO - [mozharness: 2016-09-01 14:44:04.912156Z] Running run-tests step. 07:44:04 INFO - Running pre-action listener: _resource_record_pre_action 07:44:04 INFO - Running main action method: run_tests 07:44:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:44:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:44:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:44:04 INFO - 2016-09-01 07:44:04.927 screenresolution[6766:164839] starting screenresolution argv=screenresolution get 07:44:04 INFO - 2016-09-01 07:44:04.930 screenresolution[6766:164839] Display 0: 1600x1200x32@60 07:44:04 INFO - 2016-09-01 07:44:04.935 screenresolution[6767:164841] starting screenresolution argv=screenresolution list 07:44:04 INFO - Available Modes on Display 0 07:44:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:44:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:44:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:44:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:44:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:44:05 INFO - Intel Iris: 07:44:05 INFO - Chipset Model: Intel Iris 07:44:05 INFO - Type: GPU 07:44:05 INFO - Bus: Built-In 07:44:05 INFO - VRAM (Dynamic, Max): 1536 MB 07:44:05 INFO - Vendor: Intel (0x8086) 07:44:05 INFO - Device ID: 0x0a2e 07:44:05 INFO - Revision ID: 0x0009 07:44:05 INFO - Displays: 07:44:05 INFO - Display: 07:44:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:44:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:44:05 INFO - Display Serial Number: 1600x1200 60 07:44:05 INFO - Main Display: Yes 07:44:05 INFO - Mirror: Off 07:44:05 INFO - Online: Yes 07:44:05 INFO - Rotation: Supported 07:44:05 INFO - Return code: 0 07:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:44:05 INFO - Python 2.7.3 07:44:05 INFO - Return code: 0 07:44:05 INFO - grabbing minidump binary from tooltool 07:44: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')]} 07:44:05 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 0x10ff7ad30>, '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 0x10fcdfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ff72b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:44:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:44:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:44:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:44:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:44:05 INFO - Return code: 0 07:44:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:44:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:44:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:44:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:44:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:44:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:44:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:44:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3oP8aOOaED/Render', 07:44:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:44:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:44:05 INFO - 'HOME': '/Users/cltbld', 07:44:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:44:05 INFO - 'LOGNAME': 'cltbld', 07:44:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:44:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:44:05 INFO - 'MOZ_NO_REMOTE': '1', 07:44:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:44:05 INFO - 'NO_EM_RESTART': '1', 07:44:05 INFO - 'PAGER': '/bin/cat', 07:44:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:44:05 INFO - 'PWD': '/builds/slave/test', 07:44:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:44:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:44:05 INFO - 'SHELL': '/bin/bash', 07:44:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a9MJOVn858/Listeners', 07:44:05 INFO - 'TMPDIR': '/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/', 07:44:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:44:05 INFO - 'USER': 'cltbld', 07:44:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:44:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:44:05 INFO - 'XPC_FLAGS': '0x0', 07:44:05 INFO - 'XPC_SERVICE_NAME': '0', 07:44:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:44:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:44:05 INFO - mozversion application_buildid: 20160901063021 07:44:05 INFO - mozversion application_changeset: 27ffae997b83a5bfeaf0967e692074cb097d94e8 07:44:05 INFO - mozversion application_display_name: Nightly 07:44:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:44:05 INFO - mozversion application_name: Firefox 07:44:05 INFO - mozversion application_remotingname: firefox 07:44:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:44:05 INFO - mozversion application_vendor: Mozilla 07:44:05 INFO - mozversion application_version: 51.0a1 07:44:05 INFO - mozversion platform_buildid: 20160901063021 07:44:05 INFO - mozversion platform_changeset: 27ffae997b83a5bfeaf0967e692074cb097d94e8 07:44:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:44:05 INFO - mozversion platform_version: 51.0a1 07:44:05 INFO - using testdate: 1472741045 07:44:05 INFO - actual date: 1472741045 07:44:05 INFO - starting webserver on 'localhost:61232' 07:44:05 INFO - SUITE-START | Running 2 tests 07:44:05 INFO - TEST-START | dromaeo_css 07:44:05 INFO - operating with platform_type : mac_ 07:44:05 INFO - Initialising browser for dromaeo_css test... 07:44:05 INFO - TEST-INFO | started process 6777 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp3v1HS0/profile http://localhost:61232/getInfo.html) 07:44:07 INFO - PROCESS | 6777 | __metrics Screen width/height:1600/1200 07:44:07 INFO - PROCESS | 6777 | colorDepth:24 07:44:07 INFO - PROCESS | 6777 | Browser inner width/height: 1024/689 07:44:07 INFO - PROCESS | 6777 | __metrics 07:44:08 INFO - PROCESS | 6777 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:44:08 INFO - PROCESS | 6777 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:44:08 INFO - TEST-INFO | 6777: exit 0 07:44:08 INFO - Browser initialized. 07:44:08 INFO - Running cycle 1/1 for dromaeo_css test... 07:44:08 INFO - TEST-INFO | started process 6779 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmp3v1HS0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:44:20 INFO - PROCESS | 6779 | RSS: Main: 233803776 07:44:20 INFO - PROCESS | 6779 | 07:45:12 INFO - PROCESS | 6779 | 1472741112085 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:47:24 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:61232/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61232/tests/dromaeo/cssquery-ext.html) 07:47:25 INFO - PROCESS | 6779 | RSS: Main: 388751360 07:47:25 INFO - PROCESS | 6779 | 07:50:29 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:61232/tests/dromaeo/cssquery-ext.html (next: http://localhost:61232/tests/dromaeo/cssquery-jquery.html) 07:50:29 INFO - PROCESS | 6779 | RSS: Main: 372035584 07:50:29 INFO - PROCESS | 6779 | 07:53:31 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:61232/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61232/tests/dromaeo/cssquery-mootools.html) 07:53:32 INFO - PROCESS | 6779 | RSS: Main: 335732736 07:53:32 INFO - PROCESS | 6779 | 07:56:34 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:61232/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61232/tests/dromaeo/cssquery-prototype.html) 07:56:35 INFO - PROCESS | 6779 | RSS: Main: 333385728 07:56:35 INFO - PROCESS | 6779 | 07:59:39 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:61232/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61232/tests/dromaeo/cssquery-yui.html) 07:59:39 INFO - PROCESS | 6779 | RSS: Main: 329654272 07:59:39 INFO - PROCESS | 6779 | 08:02:42 INFO - PROCESS | 6779 | Cycle 1(1): loaded http://localhost:61232/tests/dromaeo/cssquery-yui.html (next: http://localhost:61232/tests/dromaeo/cssquery-dojo.html) 08:02:43 INFO - PROCESS | 6779 | RSS: Main: 465825792 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | __start_tp_report 08:02:43 INFO - PROCESS | 6779 | _x_x_mozilla_page_load 08:02:43 INFO - PROCESS | 6779 | _x_x_mozilla_page_load_details 08:02:43 INFO - PROCESS | 6779 | |i|pagename|runs| 08:02:43 INFO - PROCESS | 6779 | |0;dojo.html;2782.819116757411;3296.3572103439824;3308.90073297801;3336.4828451589983;3368.2926585417063;5635.6618602883855;5682.119271512912;5711.114777209529;5717.171010203518;5731.398203188668;5616.354119276284;5709.857253568663;5751.741171647275;5763.337216220136;5815.21494598228;5137.229415587673;5160;5192.818251361203;5221.347331583552;5309.65487243328;5310.495502927216;5330.440303768107;5336.066188417031;5341.1988201769655;5351.57187425005;5096.847094587169;5143.974280128613;5165.354330708661;5192;5227.634065615409;4063.3295506241434;4633.25867861144;5206.219067139921;5220.843374698765;5310.176922577007;5198.9480105198845;5208.244804503363;5227.137522308814;5250.842474725764;5251.737413129328;5629.211910332557;5634.774609015634;5681.289838770153;5695.77216911323;5767.999999999958;6164.815055548341;6166.209173727951;6201.255849298068;6219.378062193789;6229.563930524865;5378.596605254583;6299.0551417287315;6310.179676642053;6321.462675672573;6323.810285691437;5662.980663480572;5784.421557844266;5838.153467747238;5858.970705146447;5912.408759124053;6288.5598008138995;6305.337939516285;6309.936900631027;6318.9889617661875;6329.145565348619;6162.938370616236;6192.97815860378;6212.72042758077;6217.689115544295;6223.875522489616;6119.228375855631;6176.258848938156;6293.905591416133;6297.96851015742;6347.587406818542;6163.537734669918;6233.438990490878;6259.405356491126;6263.96868015657;6291.653959032205;6202.472789812826;6317.4946004319545;6332.366763323631;6336.429721325103;6340.7463701451425;4850.223964165716;4907.1903135982875;4916.827911023097;4940.629452791055;4944.456109827916;4372.147431250939;4439.467263928349;4458.576435238647;4458.843940462133;4485.798139083749;5736.856578585569;5763.7982670606325;5790.565707571949;5808.419158084158;5817.127430885401;6247.5939063961605;6322.462590679752;6329.715162817684;6341.873162536724;6361.713722882481;5656.575756818255;5711.800086997018;5737;5743.59794814359;5783.768649253982;5179.22311653255;5320.17537281722;5387.595930305243;5427.348718153768;5428.240046393508;5226.529612334908;6315.936840631627;6334.3665633436285;6339.429451349401;6348.396902294275;6226.875462490634;6265.310815810349;6277.309495955533;6287.2769631492965;6316.463100636497;5299.682019078868;6237.4698150657705;6242.282137554058;6279.654618995999;6335.841603959938;6220.315765265726;6221.035739460391;6229.5327850410495;6235.563510554218;6242.812715618538;6314.336994615499;6317.052442133533;6319.747210111728;6324.683765811783;6325.399087086719;4495.932561011653;5924.940750592611;5974.551908606785;6063.181470501426;6100.298465676504;6097.161734506546;6107.416219223149;6137.254412462313;6142.928535732134;6143.508519318354;4918.286848407032;5889.969255380206;5961.2846458425265;5971.28344598651;5992.64044157352;5790.565707572033;5805.158252053513;6027.4876635484725;6113.419225173601;6118.265808103056;5938.198343223782;5972;5976.103584462366;6014.548908831767;6034.698265086816 08:02:43 INFO - PROCESS | 6779 | |1;ext.html;474.9287606858971;500.624531601299;512.2930356108571;519.0216442006816;528.5718567959952;24280.75719242807;39502.60497395025;41201.79399103008;41293.380599291;43222.70331890041;42186;42499.78750106253;42608;42639;42758.786206069;9767.462789546573;9908.801823963517;9948.204143668525;9949.95025024874;9957.701268961906;8838.646454141826;9064.818703625924;12060.336681482515;12304.077194210426;12331.691707707289;12227.877721222807;12298.077644176677;12310.81533776994;12324.32216228107;12331.630051098482;7656.3874890008665;12275.631731048083;12282.815757763641;12336.876631233663;12354.011679065654;10309.329893556895;11794.587189448328;12062.87937120635;12098.758024839542;12340.259584424874;40604.187916241804;40944.59055409468;41035;41053.973650658976;41066.1786764263;3066.080175947207;3093.938121237585;3225.870965161391;3473.4442489201606;3657.012606596231;30745.770169193205;31013.689863101306;31430.05709828709;31435.685643143504;31926.521102183488;3206.599175103112;3271.214908421962;3272.689094536015;3390.5081764023753;3405.1316914186973;491296;497290;499738;499794;500865;32770.18074548108;56626.7168664154;56991.430085698616;57101.71449142811;57296.14055789167;33380.499292510634;34602;34749.30501389958;34794.82602586971;34831.651683483346;14307.713845723027;14569.708605828037;14575.052621579563;14579.41682332716;14597;11240.831387529193;11410.144239182095;12349.691257718629;12441.688957776129;12449.93775031119;6199.907001394983;7582.203868593719;7727.150013498511;7763.874238235424;7823.882641760378;3207.615086189672;3249.69127932846;3276.4921437177277;3289.457239555494;3294.802311861296;898.7079199260266;949.6581230756922;979.4270351844251;989.4656885281867;1040.266612038511;27602.723972760417;27858.721412786017;27974;29498.967536136133;30404;1035.5236591168148;1042.8227201375785;1045.430240518919;1079.3092420850662;1106.590561492253;14740.557783266519;15227.238638068053;15340.769888451681;15477.9226103871;15630.765538516931;669498;669685;670135;670489;675697;55517.88964220693;55622.16566751502;55642;55713.72143139259;55856;1189.9881001190051;1218.5674085699627;1340.1958824705098;1379.8551152128882;1389.8888088953063;29352.97264595729;29838.55242171326;30030.849845751505;30235.848820755757;30433.98280773808;47313;47810.521894780606;47968.760156198994;47974.28038579494;48099.27851082307;519798;523897;524331;524860;525668;25971.350716232246;26286.079987200355;26414.69816272966;26497.60253596236;26788.330291742863;45075.549244508446;45410.31884521669;45761;45866.541334587564;46233.76883115563;37440.812795935846;37681.24637507289;37685;38462.42306365351;39052.6094739049;37768.62231377651;38297.808510957264;38349.041273968374;38362.42456363101;38884.027899302746;32633.673663263064;37123.88628341154;37372.81313593415;37633.68282110113;38031.429528557645;32071.839640801645;32943.810163421214;33493.330133397685;34171;34544;20496.36222258516;24729.752702472746;24871.523125837524;24960.251192464257;25005 08:02:43 INFO - PROCESS | 6779 | |2;jquery.html;353.3551268934196;369.95190625218726;374.71896077941545;382.6020938224247;406.7579790024934;15270.541883743492;20576.86827224502;20696.68954965675;21171.153153873827;21887;19353.129109190086;20989.37031889042;21135.788642113574;21240.937953102322;21665;5489;5977.551683623735;6241.875162496747;6244.687765611724;6252.34350393209;6029.155918171459;6207.937920620804;6224.533160012995;6229.034499652561;6256.7810126645345;6186.721597528122;6193.380661933816;6195.039768835838;7599.81000474987;7666.8849967250535;7675.5010924289745;7988.201179882023;8008.159143289958;8010.038795344538;8020.598970051474;7699.230076992312;7826.921730782677;7830.412719046094;7833.373330133632;7851.254130857559;22005.899705014686;25878.482430351476;27379.863100684368;28814.711852881414;29573.55639665407;1601.8958767680062;1901.372547059467;2006.8996550172578;2428.2351059416405;3123.5007196545785;16055.51833444987;16897.493075207763;16978.32086716542;17476.563085922953;18124.45626631203;1873.2694249242807;1925.1529327096032;1950.926990155409;1960.7745109312468;2001.4395969128668;99918;122409;123511.9999999991;123993.38003310015;126236;19867.503312417015;21241.575168496543;21451.46371340729;21531;21596.920153992236;34775.826120869235;34819.04038156734;34950.650493495246;35002;35008.824955875054;10579.206559508068;10587.15302775776;10748.247622666495;10759.56961721538;10944.890551094388;8739.907511561054;8805.339599529932;8832.425892316978;8986;9014.639414423349;9283.814323713488;9588.280878934107;9709.70870873875;9723.513824308757;9725.367851089657;3644.927101457956;3739.8130093495215;3740.8403394947654;3752.9061773455883;3755.3240416725253;694.9783817787844;814.7189219719187;876.4828751036791;939.4269495607674;939.4410325856105;20446.875421851943;20754.48113797137;21168.047437865334;21659.70041797497;22669.433264168198;760.2891296637662;881.7971866470748;900.6082354175954;914.7438717159206;920.7882187097006;9454.818147731534;10171.694849154537;10459.058684718411;11001;11021.173411994132;581203;581769;591375.0862491321;594689;597397;108965.73102806929;125206;133485;137813;138332.30833845967;951.2912879904377;996.6063404955003;1012.2610494339174;1012.3976234140674;1013.7668336282844;15551.455699050479;19377.806221938165;19892.403227903185;20032.098555564742;20646.896765516678;55216;55799;56752;57338.53914104293;57812;81839.59080204561;82009.58995204986;82782.58608706918;83262.33475330338;85106.72339914783;7775.22247775218;7903.644336005009;8173.750816826288;8218.958905205436;8274.503529788231;11787.764244715228;12914.806277906027;13039.087263891437;13412.731745365234;13489.2580908051;11202;11437.828432573684;11480.425978701198;11514.42427878586;11578.363190024293;9293.442393456415;10850.620228291971;11019.228653994143;11141.16441266892;11419.942900285445;11059.778804424028;11356.545738170711;11730.178887478136;11738.354390508262;11766.294022358687;6207.410296021871;7063.611501367269;7068.823279418056;7379.741709040158;7519.812004699927;9379.484128373006;11330.150238731963;11341.38918546772;11498.965093141658;11599.362035088152 08:02:43 INFO - PROCESS | 6779 | |3;mootools.html;1264.1277518512231;1406.254685016941;1529.059628328578;1720.3118752499;1912.693968964965;7770.805729856756;8241;8258;8264.33885289177;8268.214519620635;8465.746027619165;8678.218960293572;8720.476771393722;8821.823563528726;8827.470351778898;2410;2438.500107477963;2439.9756002440013;2443.2059580636273;2443.3280847766828;2394.090245706629;2423.994042472372;2439.42673471734;2448.669429626995;2448.7306396296394;2398.928032159038;2420.128753648694;2424.248482970276;2431.927042188728;2436.8181432005463;2385.689860318165;2401.86789726565;2408.5664580375524;2409.4337830609707;2432.063655492648;2355.941101472477;2390.0559279084837;2399.940001499959;2403.038784486202;2403.603405438118;8758.824823503557;8884.555772211364;8888.244499217575;8969.14793094655;8974.865377019285;5289.44460831611;5306.09796334624;5460.563154947595;5467.316585426822;5471.151971444432;3691.335559599271;3776.3957766757185;3780.9621903780885;3787;3790.8104594770425;934.5934518484481;1077.052194069222;1098.1653943003296;1105.4969988655143;1116.3469370418316;11914.927656510868;11929.105317101252;11947.402629868559;11978.70053248667;11984.940075299655;4517.706349087299;4566.840160594364;4619.284010978236;4672.883177920579;4673.626109911267;9285.48929808867;9285.860712089325;9285.907140928639;9289.767755806159;9290.303227257982;5319.2021196820015;5321.148616221386;5322.840314790563;5324.1747529133045;5325.707086110301;4192.224438478891;4471.083427897273;4975.154223781966;4985.4017517897355;4999.75001249936;3773.3019391412677;3801.7148713846573;3839.673627741673;3879.7284190106984;3898.766074035567;1177.4230626992883;1178.7544727294517;1184.5202692909386;1193.3555879824798;1198.6643739752883;806.3428305930647;875.4854102402878;906.9909300907038;925.5834874306589;937.2267878999717;5580.330360356702;5669.31968163823;5869.413058694182;5903.35063143054;6055.8486037848525;437.2719422162128;443.0629219201366;455.34203076554724;455.48985136647167;456.30413619230274;3669.1377526281303;3966.900827479336;4001.7398869074;4089.5501494835544;4093.242750091183;10353.43056131905;10849.294795838245;10858.402787846586;10876.510557024953;10895.291806032583;10397.220208484394;10559.947200263949;10746.301490403099;10796.352218866894;10818.02637762605;8172.305354044854;8242.093369729326;8268.627911743986;8298.70954516589;8353.582320883932;5432.782688692408;5493.560515158698;5744.253247077853;5856;5959.970200148971;9234.630614775602;9454.480003599869;10084.142847858015;10089.445080520642;10146.289759717045;8512.40413171072;9262.16640502331;9897.554610042422;10284;10419.270651054354;6833.077534532775;6939.236683964861;7026.613536255555;7075.575465472089;7084.964575177091;8231.876521852057;8268.09051004401;8353.83292334162;8391.580420978804;8392;7485.625718713934;7537.623118843926;7562.584057876869;7601;7701.191374905554;5902.970485147718;7382.151052628801;7383.150937642025;7413.369863561442;7413.518121322097;6824.181098268041;6957.234704182435;6966.303369662993;7037.472189585904;7041.049458323266;4685.5782979532005;4951;4962.578180854668;4993.201087825931;5155.510226528474;4951.306817045544;5078.060558796635;5135.948640513547;5149.9227511586605;5214.452482489284 08:02:43 INFO - PROCESS | 6779 | |4;prototype.html;267.30500698184716;303.4492396300714;307.3928990244268;316.7117922690351;318.03000847415404;4518.6954653126895;4662.997455547057;4893.510648935105;5271.262023316739;5471.151971444422;4385.232584297743;4473.66447516436;5402.189671549269;5402.702851343174;5439.573068966555;3863.9034024149482;3868.071662800922;3905.921881562367;4061.675065994728;4130.607592278729;4069.3895915612597;4078.653314468274;4084.4690190275223;4114.979425102885;4164.229617520753;3307.619623743264;3452.7410444216657;3601.94597081044;4021.457103291062;4029.8992525186814;2686.597010448429;3474.940143256306;3816.2367526494813;3922.2743792398214;4022.919541609166;3505.3865573524786;3513.402721537345;3523.4714792781288;3523.6476352364557;3549.5563054618174;5212.504812042887;5239.659422137587;5263.86840328991;5280.762365693553;5339.332583427072;4397.868063958086;4633.976830115827;4643.514075495843;4675.976620116911;4694.50707675696;4737.005228901935;5335.493128152819;5409.540189083933;5595.972020139914;5597.860053498654;3906.2773386923227;3915.6084391560903;3921.823517941671;3927.9214415711813;3951.9604803952166;4838.516148385169;5125.949620151931;5461.208124821918;5661.716914154317;5966.791162309299;3492.965070349315;3790.962090379116;3916.941245881314;3921.2941670499586;3924.274009308287;3989.8204580793936;4016.357382818735;4023.7786921719003;4030.1738143680477;4032.2741906457118;4078.388241763759;4347.999960009216;4669.159551280734;4673.415823022122;4709.505501922317;5243.606729495303;5464.7814087436855;5607.663540187602;5644.8024319148635;5709.8287051388525;1354.6748780292855;1367.7264547090422;1377.738229736367;1377.8966577506526;1383.979240311396;784.8391079828622;830.4685001598981;840.9411341206057;846.5851732650957;852.8592782190993;5110.821121260738;5183.537819535766;5238.952209558103;5343.7862485500145;5345.251664766935;4891.364122664031;5648.74580643872;5808.199458167982;5815.156802263648;5819.53443724501;4291.875521616757;4689.859304220879;4947.876303092379;5290.68255904647;5351.892962140813;2610.2952202905108;2786.3452088759127;2906.5349544072847;3016.8642411091555;3085.552594873731;5162.870928226825;5852.297724273115;5975.671338076448;6055.910710804766;6081.513478921675;5267.970002947748;5322.946770532322;5947.06720315899;5981.551383646244;5987.431194036647;5388.91916621251;5414.620976531605;5569.944300557105;6012.248468941382;6028.788992385245;5337.919931200958;5429.511343979061;5788.044972579477;5807.883842323215;5827.358990511125;5109.135165664431;5575.8884822304135;5779.162021506942;5800.593958423039;5827.154078308296;5072.51811077947;5839.5912286141265;6099.394956807582;6114.737547107598;6139.969300153471;3496.3706532823317;3692.593814680329;3870.9225815484097;3886.4753258309765;3898.2398432305426;5812.73842677089;5824.708764561839;5826.824380712437;5857.355690873916;5874.030784920611;5126.8974620508125;5320.637077596489;5657.813218218406;5669.773209071591;5717.685527295872;4937.876553086202;5434.782608695607;5510.641808282448;5653.162722115411;5656.377798442086;4642.651801114863;4789.329493870791;5457.972710136424;5540.398740818339;5569.972150139223;4730.645201609824;5095.821646242363;5524.8342549723575;5568.048934064952;5699.178906441338;4444.666650001198;4993.9762348717695;5368.624196306378;5471.808486703106;5564.805231816867 08:02:43 INFO - PROCESS | 6779 | |5;yui.html;659.1266571792374;661.8279247395678;670.926198118207;689.5138927056425;772.7874834420534;15041.548753537398;15194.544163675107;15776.76334854978;15829.60425989351;15944.202789860505;13982.650433739162;14112.576622701336;14260.215688137148;14260.786088208684;14261.857381426182;842.5787106446792;866.4974314897376;867.1242045534025;867.7873920889391;870.634333579898;684.8150999230205;705.048184950318;850.1286181663813;872.4721543466206;887.4763889305309;920.779013036873;922.7739203895055;925.4771054354302;926.735880274122;927.7263207353814;907.9137481939205;915.3546749541557;916.1159481100769;918.3709159225951;921.2123634292717;530.3794560364345;654.5581732330658;672.8418821576926;674.7402250133733;675.7364627795164;14657.120572765669;14710.705785884329;14714.190719510423;14723.116613003254;14723.190224537646;13490.325483725872;13770.724585508335;13921.30393480322;13971.441142354293;14119.71760564783;11536.307821530734;12422.068344874171;12552.623421297376;12566.623001309976;13064.085514014023;4197.727147735387;4441.467023957113;4550.772461376918;4641.396618439615;4646.558576935186;128026;128209.35895320556;128682.99999999907;129213;129367;10856.674299771019;10881.183911206692;10945.781084378426;10947.4526273686;11094.611688590861;21510.892445537986;21517.67723484149;21534.24630137969;21569.352919412442;21579.352619421443;7626.809329766689;7778.688852445952;7817.765467035998;7863.764087077397;7983.920160798318;4169.478815148106;4204.3903633972905;4259.8083086261195;4285.5928686774705;4287.4855017397485;3359.3449277390673;3474.4440889457564;3474.5656792900886;3476.443768996999;3478.286951175003;530.3211888782365;618.77724019353;648.3710800523485;652.083822229768;653.3368630839701;511.6162877841619;567.9716014199273;590.35356284868;601.9488343490765;615.5383462403198;8185.877211841827;8747.544645082906;8839.823203536022;8936.106389361012;9008.819823603491;515.8091506142677;530.5596355025319;538.1900240138566;588.5909293041381;632.3360471504901;4182.414461975326;4309.245881970643;4366.978165109154;4378.343248512749;4417.823287068545;92475.5376223128;108524;153991;157568;159066;128948;134478;138643.61356386307;140329;144784;102504;104606;105338.94661053445;115306.42346788212;120440.79559204471;8714.25928796034;9775.169110625677;9845.556949937414;9870.259730520384;10034.448105353984;48807;55030.44969550413;60025.794325248375;62662.686686566274;63649.6817515928;82835.5858220705;90830;91383;92180;93653;13040.152390094614;13093.869061309266;13233.536826211037;13367.264800436069;13393.464261429433;14728.189949552878;15318.846811531743;15380.38478460849;15381.30784114695;15566.688666226839;12390.380480976095;13123.803142953055;13611.591652250449;14016.859831401556;14484.203368814817;13771.380287886868;13780.862191378359;13794.37925293344;13977.301134943416;14117.43530258778;11268.605598804003;13419.210417176764;13551.457941682222;13632.795508067189;13814.930925345308;11245.269057511563;11428.428578571204;11431.542738290374;11570.19008669385;11583.884161158281;10322.587096516356;11135.55457781712;11315.490802913724;11414.543418263176;11419.31484110956 08:02:43 INFO - PROCESS | 6779 | __end_tp_report 08:02:43 INFO - PROCESS | 6779 | __start_cc_report 08:02:43 INFO - PROCESS | 6779 | _x_x_mozilla_cycle_collect,1455 08:02:43 INFO - PROCESS | 6779 | __end_cc_report 08:02:43 INFO - PROCESS | 6779 | __startTimestamp1472742163210__endTimestamp 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | ------- Summary: start ------- 08:02:43 INFO - PROCESS | 6779 | Number of tests: 6 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | [#0] dojo.html Cycles:165 Average:5717.56 Median:5912.41 stddev:686.91 (11.6%) stddev-sans-first:649.29 08:02:43 INFO - PROCESS | 6779 | Values: 2782.8 3296.4 3308.9 3336.5 3368.3 5635.7 5682.1 5711.1 5717.2 5731.4 5616.4 5709.9 5751.7 5763.3 5815.2 5137.2 5160.0 5192.8 5221.3 5309.7 5310.5 5330.4 5336.1 5341.2 5351.6 5096.8 5144.0 5165.4 5192.0 5227.6 4063.3 4633.3 5206.2 5220.8 5310.2 5198.9 5208.2 5227.1 5250.8 5251.7 5629.2 5634.8 5681.3 5695.8 5768.0 6164.8 6166.2 6201.3 6219.4 6229.6 5378.6 6299.1 6310.2 6321.5 6323.8 5663.0 5784.4 5838.2 5859.0 5912.4 6288.6 6305.3 6309.9 6319.0 6329.1 6162.9 6193.0 6212.7 6217.7 6223.9 6119.2 6176.3 6293.9 6298.0 6347.6 6163.5 6233.4 6259.4 6264.0 6291.7 6202.5 6317.5 6332.4 6336.4 6340.7 4850.2 4907.2 4916.8 4940.6 4944.5 4372.1 4439.5 4458.6 4458.8 4485.8 5736.9 5763.8 5790.6 5808.4 5817.1 6247.6 6322.5 6329.7 6341.9 6361.7 5656.6 5711.8 5737.0 5743.6 5783.8 5179.2 5320.2 5387.6 5427.3 5428.2 5226.5 6315.9 6334.4 6339.4 6348.4 6226.9 6265.3 6277.3 6287.3 6316.5 5299.7 6237.5 6242.3 6279.7 6335.8 6220.3 6221.0 6229.5 6235.6 6242.8 6314.3 6317.1 6319.7 6324.7 6325.4 4495.9 5924.9 5974.6 6063.2 6100.3 6097.2 6107.4 6137.3 6142.9 6143.5 4918.3 5890.0 5961.3 5971.3 5992.6 5790.6 5805.2 6027.5 6113.4 6118.3 5938.2 5972.0 5976.1 6014.5 6034.7 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | [#1] ext.html Cycles:180 Average:68214.04 Median:19037.72 stddev:152455.20 (800.8%) stddev-sans-first:152798.04 08:02:43 INFO - PROCESS | 6779 | Values: 474.9 500.6 512.3 519.0 528.6 24280.8 39502.6 41201.8 41293.4 43222.7 42186.0 42499.8 42608.0 42639.0 42758.8 9767.5 9908.8 9948.2 9950.0 9957.7 8838.6 9064.8 12060.3 12304.1 12331.7 12227.9 12298.1 12310.8 12324.3 12331.6 7656.4 12275.6 12282.8 12336.9 12354.0 10309.3 11794.6 12062.9 12098.8 12340.3 40604.2 40944.6 41035.0 41054.0 41066.2 3066.1 3093.9 3225.9 3473.4 3657.0 30745.8 31013.7 31430.1 31435.7 31926.5 3206.6 3271.2 3272.7 3390.5 3405.1 491296.0 497290.0 499738.0 499794.0 500865.0 32770.2 56626.7 56991.4 57101.7 57296.1 33380.5 34602.0 34749.3 34794.8 34831.7 14307.7 14569.7 14575.1 14579.4 14597.0 11240.8 11410.1 12349.7 12441.7 12449.9 6199.9 7582.2 7727.2 7763.9 7823.9 3207.6 3249.7 3276.5 3289.5 3294.8 898.7 949.7 979.4 989.5 1040.3 27602.7 27858.7 27974.0 29499.0 30404.0 1035.5 1042.8 1045.4 1079.3 1106.6 14740.6 15227.2 15340.8 15477.9 15630.8 669498.0 669685.0 670135.0 670489.0 675697.0 55517.9 55622.2 55642.0 55713.7 55856.0 1190.0 1218.6 1340.2 1379.9 1389.9 29353.0 29838.6 30030.8 30235.8 30434.0 47313.0 47810.5 47968.8 47974.3 48099.3 519798.0 523897.0 524331.0 524860.0 525668.0 25971.4 26286.1 26414.7 26497.6 26788.3 45075.5 45410.3 45761.0 45866.5 46233.8 37440.8 37681.2 37685.0 38462.4 39052.6 37768.6 38297.8 38349.0 38362.4 38884.0 32633.7 37123.9 37372.8 37633.7 38031.4 32071.8 32943.8 33493.3 34171.0 34544.0 20496.4 24729.8 24871.5 24960.3 25005.0 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | [#2] jquery.html Cycles:180 Average:36558.90 Median:34884.85 stddev:98321.16 (281.8%) stddev-sans-first:98559.40 08:02:43 INFO - PROCESS | 6779 | Values: 353.4 370.0 374.7 382.6 406.8 15270.5 20576.9 20696.7 21171.2 21887.0 19353.1 20989.4 21135.8 21240.9 21665.0 5489.0 5977.6 6241.9 6244.7 6252.3 6029.2 6207.9 6224.5 6229.0 6256.8 6186.7 6193.4 6195.0 7599.8 7666.9 7675.5 7988.2 8008.2 8010.0 8020.6 7699.2 7826.9 7830.4 7833.4 7851.3 22005.9 25878.5 27379.9 28814.7 29573.6 1601.9 1901.4 2006.9 2428.2 3123.5 16055.5 16897.5 16978.3 17476.6 18124.5 1873.3 1925.2 1950.9 1960.8 2001.4 99918.0 122409.0 123512.0 123993.4 126236.0 19867.5 21241.6 21451.5 21531.0 21596.9 34775.8 34819.0 34950.7 35002.0 35008.8 10579.2 10587.2 10748.2 10759.6 10944.9 8739.9 8805.3 8832.4 8986.0 9014.6 9283.8 9588.3 9709.7 9723.5 9725.4 3644.9 3739.8 3740.8 3752.9 3755.3 695.0 814.7 876.5 939.4 939.4 20446.9 20754.5 21168.0 21659.7 22669.4 760.3 881.8 900.6 914.7 920.8 9454.8 10171.7 10459.1 11001.0 11021.2 581203.0 581769.0 591375.1 594689.0 597397.0 108965.7 125206.0 133485.0 137813.0 138332.3 951.3 996.6 1012.3 1012.4 1013.8 15551.5 19377.8 19892.4 20032.1 20646.9 55216.0 55799.0 56752.0 57338.5 57812.0 81839.6 82009.6 82782.6 83262.3 85106.7 7775.2 7903.6 8173.8 8219.0 8274.5 11787.8 12914.8 13039.1 13412.7 13489.3 11202.0 11437.8 11480.4 11514.4 11578.4 9293.4 10850.6 11019.2 11141.2 11419.9 11059.8 11356.5 11730.2 11738.4 11766.3 6207.4 7063.6 7068.8 7379.7 7519.8 9379.5 11330.2 11341.4 11499.0 11599.4 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | [#3] mootools.html Cycles:180 Average:5654.74 Median:4980.28 stddev:3174.78 (63.7%) stddev-sans-first:3166.53 08:02:43 INFO - PROCESS | 6779 | Values: 1264.1 1406.3 1529.1 1720.3 1912.7 7770.8 8241.0 8258.0 8264.3 8268.2 8465.7 8678.2 8720.5 8821.8 8827.5 2410.0 2438.5 2440.0 2443.2 2443.3 2394.1 2424.0 2439.4 2448.7 2448.7 2398.9 2420.1 2424.2 2431.9 2436.8 2385.7 2401.9 2408.6 2409.4 2432.1 2355.9 2390.1 2399.9 2403.0 2403.6 8758.8 8884.6 8888.2 8969.1 8974.9 5289.4 5306.1 5460.6 5467.3 5471.2 3691.3 3776.4 3781.0 3787.0 3790.8 934.6 1077.1 1098.2 1105.5 1116.3 11914.9 11929.1 11947.4 11978.7 11984.9 4517.7 4566.8 4619.3 4672.9 4673.6 9285.5 9285.9 9285.9 9289.8 9290.3 5319.2 5321.1 5322.8 5324.2 5325.7 4192.2 4471.1 4975.2 4985.4 4999.8 3773.3 3801.7 3839.7 3879.7 3898.8 1177.4 1178.8 1184.5 1193.4 1198.7 806.3 875.5 907.0 925.6 937.2 5580.3 5669.3 5869.4 5903.4 6055.8 437.3 443.1 455.3 455.5 456.3 3669.1 3966.9 4001.7 4089.6 4093.2 10353.4 10849.3 10858.4 10876.5 10895.3 10397.2 10559.9 10746.3 10796.4 10818.0 8172.3 8242.1 8268.6 8298.7 8353.6 5432.8 5493.6 5744.3 5856.0 5960.0 9234.6 9454.5 10084.1 10089.4 10146.3 8512.4 9262.2 9897.6 10284.0 10419.3 6833.1 6939.2 7026.6 7075.6 7085.0 8231.9 8268.1 8353.8 8391.6 8392.0 7485.6 7537.6 7562.6 7601.0 7701.2 5903.0 7382.2 7383.2 7413.4 7413.5 6824.2 6957.2 6966.3 7037.5 7041.0 4685.6 4951.0 4962.6 4993.2 5155.5 4951.3 5078.1 5135.9 5149.9 5214.5 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | [#4] prototype.html Cycles:180 Average:4526.33 Median:5118.39 stddev:1402.42 (27.4%) stddev-sans-first:1369.44 08:02:43 INFO - PROCESS | 6779 | Values: 267.3 303.4 307.4 316.7 318.0 4518.7 4663.0 4893.5 5271.3 5471.2 4385.2 4473.7 5402.2 5402.7 5439.6 3863.9 3868.1 3905.9 4061.7 4130.6 4069.4 4078.7 4084.5 4115.0 4164.2 3307.6 3452.7 3601.9 4021.5 4029.9 2686.6 3474.9 3816.2 3922.3 4022.9 3505.4 3513.4 3523.5 3523.6 3549.6 5212.5 5239.7 5263.9 5280.8 5339.3 4397.9 4634.0 4643.5 4676.0 4694.5 4737.0 5335.5 5409.5 5596.0 5597.9 3906.3 3915.6 3921.8 3927.9 3952.0 4838.5 5125.9 5461.2 5661.7 5966.8 3493.0 3791.0 3916.9 3921.3 3924.3 3989.8 4016.4 4023.8 4030.2 4032.3 4078.4 4348.0 4669.2 4673.4 4709.5 5243.6 5464.8 5607.7 5644.8 5709.8 1354.7 1367.7 1377.7 1377.9 1384.0 784.8 830.5 840.9 846.6 852.9 5110.8 5183.5 5239.0 5343.8 5345.3 4891.4 5648.7 5808.2 5815.2 5819.5 4291.9 4689.9 4947.9 5290.7 5351.9 2610.3 2786.3 2906.5 3016.9 3085.6 5162.9 5852.3 5975.7 6055.9 6081.5 5268.0 5322.9 5947.1 5981.6 5987.4 5388.9 5414.6 5569.9 6012.2 6028.8 5337.9 5429.5 5788.0 5807.9 5827.4 5109.1 5575.9 5779.2 5800.6 5827.2 5072.5 5839.6 6099.4 6114.7 6140.0 3496.4 3692.6 3870.9 3886.5 3898.2 5812.7 5824.7 5826.8 5857.4 5874.0 5126.9 5320.6 5657.8 5669.8 5717.7 4937.9 5434.8 5510.6 5653.2 5656.4 4642.7 4789.3 5458.0 5540.4 5570.0 4730.6 5095.8 5524.8 5568.0 5699.2 4444.7 4994.0 5368.6 5471.8 5564.8 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - PROCESS | 6779 | [#5] yui.html Cycles:180 Average:25068.54 Median:3416.89 stddev:40394.15 (1182.2%) stddev-sans-first:40465.89 08:02:43 INFO - PROCESS | 6779 | Values: 659.1 661.8 670.9 689.5 772.8 15041.5 15194.5 15776.8 15829.6 15944.2 13982.7 14112.6 14260.2 14260.8 14261.9 842.6 866.5 867.1 867.8 870.6 684.8 705.0 850.1 872.5 887.5 920.8 922.8 925.5 926.7 927.7 907.9 915.4 916.1 918.4 921.2 530.4 654.6 672.8 674.7 675.7 14657.1 14710.7 14714.2 14723.1 14723.2 13490.3 13770.7 13921.3 13971.4 14119.7 11536.3 12422.1 12552.6 12566.6 13064.1 4197.7 4441.5 4550.8 4641.4 4646.6 128026.0 128209.4 128683.0 129213.0 129367.0 10856.7 10881.2 10945.8 10947.5 11094.6 21510.9 21517.7 21534.2 21569.4 21579.4 7626.8 7778.7 7817.8 7863.8 7983.9 4169.5 4204.4 4259.8 4285.6 4287.5 3359.3 3474.4 3474.6 3476.4 3478.3 530.3 618.8 648.4 652.1 653.3 511.6 568.0 590.4 601.9 615.5 8185.9 8747.5 8839.8 8936.1 9008.8 515.8 530.6 538.2 588.6 632.3 4182.4 4309.2 4367.0 4378.3 4417.8 92475.5 108524.0 153991.0 157568.0 159066.0 128948.0 134478.0 138643.6 140329.0 144784.0 102504.0 104606.0 105338.9 115306.4 120440.8 8714.3 9775.2 9845.6 9870.3 10034.4 48807.0 55030.4 60025.8 62662.7 63649.7 82835.6 90830.0 91383.0 92180.0 93653.0 13040.2 13093.9 13233.5 13367.3 13393.5 14728.2 15318.8 15380.4 15381.3 15566.7 12390.4 13123.8 13611.6 14016.9 14484.2 13771.4 13780.9 13794.4 13977.3 14117.4 11268.6 13419.2 13551.5 13632.8 13814.9 11245.3 11428.4 11431.5 11570.2 11583.9 10322.6 11135.6 11315.5 11414.5 11419.3 08:02:43 INFO - PROCESS | 6779 | -------- Summary: end -------- 08:02:43 INFO - PROCESS | 6779 | 08:02:43 INFO - TEST-INFO | 6779: exit 0 08:02:43 INFO - TEST-OK | dromaeo_css | took 1118398ms 08:02:43 INFO - TEST-START | kraken 08:02:43 INFO - operating with platform_type : mac_ 08:02:43 INFO - Initialising browser for kraken test... 08:02:43 INFO - TEST-INFO | started process 6781 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpIAXPh2/profile http://localhost:61232/getInfo.html) 08:02:46 INFO - PROCESS | 6781 | __metrics Screen width/height:1600/1200 08:02:46 INFO - PROCESS | 6781 | colorDepth:24 08:02:46 INFO - PROCESS | 6781 | Browser inner width/height: 1024/689 08:02:46 INFO - PROCESS | 6781 | __metrics 08:02:46 INFO - PROCESS | 6781 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:02:46 INFO - PROCESS | 6781 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:47 INFO - TEST-INFO | 6781: exit 0 08:02:47 INFO - Browser initialized. 08:02:47 INFO - Running cycle 1/1 for kraken test... 08:02:47 INFO - TEST-INFO | started process 6782 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/tmpIAXPh2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:02:59 INFO - PROCESS | 6782 | RSS: Main: 234254336 08:02:59 INFO - PROCESS | 6782 | 08:03:01 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61232/tests/kraken/driver.html?testName=audio-beat-detection) 08:03:02 INFO - PROCESS | 6782 | RSS: Main: 292614144 08:03:02 INFO - PROCESS | 6782 | 08:03:05 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61232/tests/kraken/driver.html?testName=audio-dft) 08:03:05 INFO - PROCESS | 6782 | RSS: Main: 289157120 08:03:05 INFO - PROCESS | 6782 | 08:03:09 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61232/tests/kraken/driver.html?testName=audio-fft) 08:03:10 INFO - PROCESS | 6782 | RSS: Main: 377278464 08:03:10 INFO - PROCESS | 6782 | 08:03:12 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61232/tests/kraken/driver.html?testName=audio-oscillator) 08:03:12 INFO - PROCESS | 6782 | RSS: Main: 281268224 08:03:12 INFO - PROCESS | 6782 | 08:03:14 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61232/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:03:15 INFO - PROCESS | 6782 | RSS: Main: 284463104 08:03:15 INFO - PROCESS | 6782 | 08:03:18 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61232/tests/kraken/driver.html?testName=imaging-darkroom) 08:03:18 INFO - PROCESS | 6782 | RSS: Main: 323063808 08:03:18 INFO - PROCESS | 6782 | 08:03:21 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61232/tests/kraken/driver.html?testName=imaging-desaturate) 08:03:22 INFO - PROCESS | 6782 | RSS: Main: 325111808 08:03:22 INFO - PROCESS | 6782 | 08:03:25 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61232/tests/kraken/driver.html?testName=json-parse-financial) 08:03:25 INFO - PROCESS | 6782 | RSS: Main: 323772416 08:03:25 INFO - PROCESS | 6782 | 08:03:27 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61232/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:03:28 INFO - PROCESS | 6782 | RSS: Main: 298156032 08:03:28 INFO - PROCESS | 6782 | 08:03:30 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:03:30 INFO - PROCESS | 6782 | RSS: Main: 304635904 08:03:30 INFO - PROCESS | 6782 | 08:03:32 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:03:33 INFO - PROCESS | 6782 | RSS: Main: 304517120 08:03:33 INFO - PROCESS | 6782 | 08:03:36 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:37 INFO - PROCESS | 6782 | RSS: Main: 320024576 08:03:37 INFO - PROCESS | 6782 | 08:03:39 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:40 INFO - PROCESS | 6782 | RSS: Main: 316252160 08:03:40 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | Cycle 1(1): loaded http://localhost:61232/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61232/tests/kraken/driver.html?testName=ai-astar) 08:03:42 INFO - PROCESS | 6782 | RSS: Main: 359960576 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | __start_tp_report 08:03:42 INFO - PROCESS | 6782 | _x_x_mozilla_page_load 08:03:42 INFO - PROCESS | 6782 | _x_x_mozilla_page_load_details 08:03:42 INFO - PROCESS | 6782 | |i|pagename|runs| 08:03:42 INFO - PROCESS | 6782 | |0;ai-astar;112;113;116;113;110;112;112;111;113;123 08:03:42 INFO - PROCESS | 6782 | |1;audio-beat-detection;153;114;128;164;108;130;129;108;162;108 08:03:42 INFO - PROCESS | 6782 | |2;audio-dft;188;185;185;183;185;184;183;182;185;184 08:03:42 INFO - PROCESS | 6782 | |3;audio-fft;77;76;79;158;60;49;46;68;134;73 08:03:42 INFO - PROCESS | 6782 | |4;audio-oscillator;82;82;140;70;70;72;151;97;100;121 08:03:42 INFO - PROCESS | 6782 | |5;imaging-gaussian-blur;86;84;87;83;86;83;87;84;86;83 08:03:42 INFO - PROCESS | 6782 | |6;imaging-darkroom;95;96;96;124;94;96;96;96;96;95 08:03:42 INFO - PROCESS | 6782 | |7;imaging-desaturate;87;86;85;85;84;83;84;83;93;129 08:03:42 INFO - PROCESS | 6782 | |8;json-parse-financial;53;55;55;55;54;55;52;54;54;55 08:03:42 INFO - PROCESS | 6782 | |9;json-stringify-tinderbox;67;71;110;118;85;77;73;73;71;72 08:03:42 INFO - PROCESS | 6782 | |10;stanford-crypto-aes;86;85;86;85;88;87;84;87;89;86 08:03:42 INFO - PROCESS | 6782 | |11;stanford-crypto-ccm;142;139;137;139;140;138;141;134;183;141 08:03:42 INFO - PROCESS | 6782 | |12;stanford-crypto-pbkdf2;173;174;174;184;175;170;172;174;174;173 08:03:42 INFO - PROCESS | 6782 | |13;stanford-crypto-sha256-iterative;71;69;67;68;70;68;69;66;67;69 08:03:42 INFO - PROCESS | 6782 | __end_tp_report 08:03:42 INFO - PROCESS | 6782 | __start_cc_report 08:03:42 INFO - PROCESS | 6782 | _x_x_mozilla_cycle_collect,2015 08:03:42 INFO - PROCESS | 6782 | __end_cc_report 08:03:42 INFO - PROCESS | 6782 | __startTimestamp1472742222576__endTimestamp 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | ------- Summary: start ------- 08:03:42 INFO - PROCESS | 6782 | Number of tests: 14 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:3.69 (3.3%) stddev-sans-first:3.87 08:03:42 INFO - PROCESS | 6782 | Values: 112.0 113.0 116.0 113.0 110.0 112.0 112.0 111.0 113.0 123.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:129.50 stddev:22.16 (17.1%) stddev-sans-first:21.95 08:03:42 INFO - PROCESS | 6782 | Values: 153.0 114.0 128.0 164.0 108.0 130.0 129.0 108.0 162.0 108.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#2] audio-dft Cycles:10 Average:184.40 Median:185.00 stddev:1.65 (0.9%) stddev-sans-first:1.12 08:03:42 INFO - PROCESS | 6782 | Values: 188.0 185.0 185.0 183.0 185.0 184.0 183.0 182.0 185.0 184.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#3] audio-fft Cycles:10 Average:82.00 Median:70.50 stddev:36.05 (51.1%) stddev-sans-first:38.19 08:03:42 INFO - PROCESS | 6782 | Values: 77.0 76.0 79.0 158.0 60.0 49.0 46.0 68.0 134.0 73.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:71.00 stddev:29.55 (41.6%) stddev-sans-first:30.74 08:03:42 INFO - PROCESS | 6782 | Values: 82.0 82.0 140.0 70.0 70.0 72.0 151.0 97.0 100.0 121.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.72 08:03:42 INFO - PROCESS | 6782 | Values: 86.0 84.0 87.0 83.0 86.0 83.0 87.0 84.0 86.0 83.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:96.00 stddev:9.02 (9.4%) stddev-sans-first:9.48 08:03:42 INFO - PROCESS | 6782 | Values: 95.0 96.0 96.0 124.0 94.0 96.0 96.0 96.0 96.0 95.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#7] imaging-desaturate Cycles:10 Average:89.90 Median:85.00 stddev:14.04 (16.5%) stddev-sans-first:14.86 08:03:42 INFO - PROCESS | 6782 | Values: 87.0 86.0 85.0 85.0 84.0 83.0 84.0 83.0 93.0 129.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 08:03:42 INFO - PROCESS | 6782 | Values: 53.0 55.0 55.0 55.0 54.0 55.0 52.0 54.0 54.0 55.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#9] json-stringify-tinderbox Cycles:10 Average:81.70 Median:72.50 stddev:17.77 (24.5%) stddev-sans-first:18.03 08:03:42 INFO - PROCESS | 6782 | Values: 67.0 71.0 110.0 118.0 85.0 77.0 73.0 73.0 71.0 72.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:1.49 (1.7%) stddev-sans-first:1.58 08:03:42 INFO - PROCESS | 6782 | Values: 86.0 85.0 86.0 85.0 88.0 87.0 84.0 87.0 89.0 86.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#11] stanford-crypto-ccm Cycles:10 Average:143.40 Median:140.50 stddev:14.10 (10.0%) stddev-sans-first:14.95 08:03:42 INFO - PROCESS | 6782 | Values: 142.0 139.0 137.0 139.0 140.0 138.0 141.0 134.0 183.0 141.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:174.00 stddev:3.68 (2.1%) stddev-sans-first:3.88 08:03:42 INFO - PROCESS | 6782 | Values: 173.0 174.0 174.0 184.0 175.0 170.0 172.0 174.0 174.0 173.0 08:03:42 INFO - PROCESS | 6782 | 08:03:42 INFO - PROCESS | 6782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.27 08:03:42 INFO - PROCESS | 6782 | Values: 71.0 69.0 67.0 68.0 70.0 68.0 69.0 66.0 67.0 69.0 08:03:42 INFO - PROCESS | 6782 | -------- Summary: end -------- 08:03:42 INFO - PROCESS | 6782 | 08:03:43 INFO - TEST-INFO | 6782: exit 0 08:03:43 INFO - TEST-OK | kraken | took 59601ms 08:03:43 INFO - SUITE-END | took 1177s 08:03:43 INFO - Completed test suite (00:19:38) 08:03:43 INFO - javascript benchmark 08:03:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2782.819116757411, 3296.3572103439824, 3308.90073297801, 3336.4828451589983, 3368.2926585417063, 5635.6618602883855, 5682.119271512912, 5711.114777209529, 5717.171010203518, 5731.398203188668, 5616.354119276284, 5709.857253568663, 5751.741171647275, 5763.337216220136, 5815.21494598228, 5137.229415587673, 5160.0, 5192.818251361203, 5221.347331583552, 5309.65487243328, 5310.495502927216, 5330.440303768107, 5336.066188417031, 5341.1988201769655, 5351.57187425005, 5096.847094587169, 5143.974280128613, 5165.354330708661, 5192.0, 5227.634065615409, 4063.3295506241434, 4633.25867861144, 5206.219067139921, 5220.843374698765, 5310.176922577007, 5198.9480105198845, 5208.244804503363, 5227.137522308814, 5250.842474725764, 5251.737413129328, 5629.211910332557, 5634.774609015634, 5681.289838770153, 5695.77216911323, 5767.999999999958, 6164.815055548341, 6166.209173727951, 6201.255849298068, 6219.378062193789, 6229.563930524865, 5378.596605254583, 6299.0551417287315, 6310.179676642053, 6321.462675672573, 6323.810285691437, 5662.980663480572, 5784.421557844266, 5838.153467747238, 5858.970705146447, 5912.408759124053, 6288.5598008138995, 6305.337939516285, 6309.936900631027, 6318.9889617661875, 6329.145565348619, 6162.938370616236, 6192.97815860378, 6212.72042758077, 6217.689115544295, 6223.875522489616, 6119.228375855631, 6176.258848938156, 6293.905591416133, 6297.96851015742, 6347.587406818542, 6163.537734669918, 6233.438990490878, 6259.405356491126, 6263.96868015657, 6291.653959032205, 6202.472789812826, 6317.4946004319545, 6332.366763323631, 6336.429721325103, 6340.7463701451425, 4850.223964165716, 4907.1903135982875, 4916.827911023097, 4940.629452791055, 4944.456109827916, 4372.147431250939, 4439.467263928349, 4458.576435238647, 4458.843940462133, 4485.798139083749, 5736.856578585569, 5763.7982670606325, 5790.565707571949, 5808.419158084158, 5817.127430885401, 6247.5939063961605, 6322.462590679752, 6329.715162817684, 6341.873162536724, 6361.713722882481, 5656.575756818255, 5711.800086997018, 5737.0, 5743.59794814359, 5783.768649253982, 5179.22311653255, 5320.17537281722, 5387.595930305243, 5427.348718153768, 5428.240046393508, 5226.529612334908, 6315.936840631627, 6334.3665633436285, 6339.429451349401, 6348.396902294275, 6226.875462490634, 6265.310815810349, 6277.309495955533, 6287.2769631492965, 6316.463100636497, 5299.682019078868, 6237.4698150657705, 6242.282137554058, 6279.654618995999, 6335.841603959938, 6220.315765265726, 6221.035739460391, 6229.5327850410495, 6235.563510554218, 6242.812715618538, 6314.336994615499, 6317.052442133533, 6319.747210111728, 6324.683765811783, 6325.399087086719, 4495.932561011653, 5924.940750592611, 5974.551908606785, 6063.181470501426, 6100.298465676504, 6097.161734506546, 6107.416219223149, 6137.254412462313, 6142.928535732134, 6143.508519318354, 4918.286848407032, 5889.969255380206, 5961.2846458425265, 5971.28344598651, 5992.64044157352, 5790.565707572033, 5805.158252053513, 6027.4876635484725, 6113.419225173601, 6118.265808103056, 5938.198343223782, 5972.0, 5976.103584462366, 6014.548908831767, 6034.698265086816], "value": 5672.365339629974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.9287606858971, 500.624531601299, 512.2930356108571, 519.0216442006816, 528.5718567959952, 24280.75719242807, 39502.60497395025, 41201.79399103008, 41293.380599291, 43222.70331890041, 42186.0, 42499.78750106253, 42608.0, 42639.0, 42758.786206069, 9767.462789546573, 9908.801823963517, 9948.204143668525, 9949.95025024874, 9957.701268961906, 8838.646454141826, 9064.818703625924, 12060.336681482515, 12304.077194210426, 12331.691707707289, 12227.877721222807, 12298.077644176677, 12310.81533776994, 12324.32216228107, 12331.630051098482, 7656.3874890008665, 12275.631731048083, 12282.815757763641, 12336.876631233663, 12354.011679065654, 10309.329893556895, 11794.587189448328, 12062.87937120635, 12098.758024839542, 12340.259584424874, 40604.187916241804, 40944.59055409468, 41035.0, 41053.973650658976, 41066.1786764263, 3066.080175947207, 3093.938121237585, 3225.870965161391, 3473.4442489201606, 3657.012606596231, 30745.770169193205, 31013.689863101306, 31430.05709828709, 31435.685643143504, 31926.521102183488, 3206.599175103112, 3271.214908421962, 3272.689094536015, 3390.5081764023753, 3405.1316914186973, 491296.0, 497290.0, 499738.0, 499794.0, 500865.0, 32770.18074548108, 56626.7168664154, 56991.430085698616, 57101.71449142811, 57296.14055789167, 33380.499292510634, 34602.0, 34749.30501389958, 34794.82602586971, 34831.651683483346, 14307.713845723027, 14569.708605828037, 14575.052621579563, 14579.41682332716, 14597.0, 11240.831387529193, 11410.144239182095, 12349.691257718629, 12441.688957776129, 12449.93775031119, 6199.907001394983, 7582.203868593719, 7727.150013498511, 7763.874238235424, 7823.882641760378, 3207.615086189672, 3249.69127932846, 3276.4921437177277, 3289.457239555494, 3294.802311861296, 898.7079199260266, 949.6581230756922, 979.4270351844251, 989.4656885281867, 1040.266612038511, 27602.723972760417, 27858.721412786017, 27974.0, 29498.967536136133, 30404.0, 1035.5236591168148, 1042.8227201375785, 1045.430240518919, 1079.3092420850662, 1106.590561492253, 14740.557783266519, 15227.238638068053, 15340.769888451681, 15477.9226103871, 15630.765538516931, 669498.0, 669685.0, 670135.0, 670489.0, 675697.0, 55517.88964220693, 55622.16566751502, 55642.0, 55713.72143139259, 55856.0, 1189.9881001190051, 1218.5674085699627, 1340.1958824705098, 1379.8551152128882, 1389.8888088953063, 29352.97264595729, 29838.55242171326, 30030.849845751505, 30235.848820755757, 30433.98280773808, 47313.0, 47810.521894780606, 47968.760156198994, 47974.28038579494, 48099.27851082307, 519798.0, 523897.0, 524331.0, 524860.0, 525668.0, 25971.350716232246, 26286.079987200355, 26414.69816272966, 26497.60253596236, 26788.330291742863, 45075.549244508446, 45410.31884521669, 45761.0, 45866.541334587564, 46233.76883115563, 37440.812795935846, 37681.24637507289, 37685.0, 38462.42306365351, 39052.6094739049, 37768.62231377651, 38297.808510957264, 38349.041273968374, 38362.42456363101, 38884.027899302746, 32633.673663263064, 37123.88628341154, 37372.81313593415, 37633.68282110113, 38031.429528557645, 32071.839640801645, 32943.810163421214, 33493.330133397685, 34171.0, 34544.0, 20496.36222258516, 24729.752702472746, 24871.523125837524, 24960.251192464257, 25005.0], "value": 18738.051127272643, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.3551268934196, 369.95190625218726, 374.71896077941545, 382.6020938224247, 406.7579790024934, 15270.541883743492, 20576.86827224502, 20696.68954965675, 21171.153153873827, 21887.0, 19353.129109190086, 20989.37031889042, 21135.788642113574, 21240.937953102322, 21665.0, 5489.0, 5977.551683623735, 6241.875162496747, 6244.687765611724, 6252.34350393209, 6029.155918171459, 6207.937920620804, 6224.533160012995, 6229.034499652561, 6256.7810126645345, 6186.721597528122, 6193.380661933816, 6195.039768835838, 7599.81000474987, 7666.8849967250535, 7675.5010924289745, 7988.201179882023, 8008.159143289958, 8010.038795344538, 8020.598970051474, 7699.230076992312, 7826.921730782677, 7830.412719046094, 7833.373330133632, 7851.254130857559, 22005.899705014686, 25878.482430351476, 27379.863100684368, 28814.711852881414, 29573.55639665407, 1601.8958767680062, 1901.372547059467, 2006.8996550172578, 2428.2351059416405, 3123.5007196545785, 16055.51833444987, 16897.493075207763, 16978.32086716542, 17476.563085922953, 18124.45626631203, 1873.2694249242807, 1925.1529327096032, 1950.926990155409, 1960.7745109312468, 2001.4395969128668, 99918.0, 122409.0, 123511.9999999991, 123993.38003310015, 126236.0, 19867.503312417015, 21241.575168496543, 21451.46371340729, 21531.0, 21596.920153992236, 34775.826120869235, 34819.04038156734, 34950.650493495246, 35002.0, 35008.824955875054, 10579.206559508068, 10587.15302775776, 10748.247622666495, 10759.56961721538, 10944.890551094388, 8739.907511561054, 8805.339599529932, 8832.425892316978, 8986.0, 9014.639414423349, 9283.814323713488, 9588.280878934107, 9709.70870873875, 9723.513824308757, 9725.367851089657, 3644.927101457956, 3739.8130093495215, 3740.8403394947654, 3752.9061773455883, 3755.3240416725253, 694.9783817787844, 814.7189219719187, 876.4828751036791, 939.4269495607674, 939.4410325856105, 20446.875421851943, 20754.48113797137, 21168.047437865334, 21659.70041797497, 22669.433264168198, 760.2891296637662, 881.7971866470748, 900.6082354175954, 914.7438717159206, 920.7882187097006, 9454.818147731534, 10171.694849154537, 10459.058684718411, 11001.0, 11021.173411994132, 581203.0, 581769.0, 591375.0862491321, 594689.0, 597397.0, 108965.73102806929, 125206.0, 133485.0, 137813.0, 138332.30833845967, 951.2912879904377, 996.6063404955003, 1012.2610494339174, 1012.3976234140674, 1013.7668336282844, 15551.455699050479, 19377.806221938165, 19892.403227903185, 20032.098555564742, 20646.896765516678, 55216.0, 55799.0, 56752.0, 57338.53914104293, 57812.0, 81839.59080204561, 82009.58995204986, 82782.58608706918, 83262.33475330338, 85106.72339914783, 7775.22247775218, 7903.644336005009, 8173.750816826288, 8218.958905205436, 8274.503529788231, 11787.764244715228, 12914.806277906027, 13039.087263891437, 13412.731745365234, 13489.2580908051, 11202.0, 11437.828432573684, 11480.425978701198, 11514.42427878586, 11578.363190024293, 9293.442393456415, 10850.620228291971, 11019.228653994143, 11141.16441266892, 11419.942900285445, 11059.778804424028, 11356.545738170711, 11730.178887478136, 11738.354390508262, 11766.294022358687, 6207.410296021871, 7063.611501367269, 7068.823279418056, 7379.741709040158, 7519.812004699927, 9379.484128373006, 11330.150238731963, 11341.38918546772, 11498.965093141658, 11599.362035088152], "value": 10851.066119512909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1264.1277518512231, 1406.254685016941, 1529.059628328578, 1720.3118752499, 1912.693968964965, 7770.805729856756, 8241.0, 8258.0, 8264.33885289177, 8268.214519620635, 8465.746027619165, 8678.218960293572, 8720.476771393722, 8821.823563528726, 8827.470351778898, 2410.0, 2438.500107477963, 2439.9756002440013, 2443.2059580636273, 2443.3280847766828, 2394.090245706629, 2423.994042472372, 2439.42673471734, 2448.669429626995, 2448.7306396296394, 2398.928032159038, 2420.128753648694, 2424.248482970276, 2431.927042188728, 2436.8181432005463, 2385.689860318165, 2401.86789726565, 2408.5664580375524, 2409.4337830609707, 2432.063655492648, 2355.941101472477, 2390.0559279084837, 2399.940001499959, 2403.038784486202, 2403.603405438118, 8758.824823503557, 8884.555772211364, 8888.244499217575, 8969.14793094655, 8974.865377019285, 5289.44460831611, 5306.09796334624, 5460.563154947595, 5467.316585426822, 5471.151971444432, 3691.335559599271, 3776.3957766757185, 3780.9621903780885, 3787.0, 3790.8104594770425, 934.5934518484481, 1077.052194069222, 1098.1653943003296, 1105.4969988655143, 1116.3469370418316, 11914.927656510868, 11929.105317101252, 11947.402629868559, 11978.70053248667, 11984.940075299655, 4517.706349087299, 4566.840160594364, 4619.284010978236, 4672.883177920579, 4673.626109911267, 9285.48929808867, 9285.860712089325, 9285.907140928639, 9289.767755806159, 9290.303227257982, 5319.2021196820015, 5321.148616221386, 5322.840314790563, 5324.1747529133045, 5325.707086110301, 4192.224438478891, 4471.083427897273, 4975.154223781966, 4985.4017517897355, 4999.75001249936, 3773.3019391412677, 3801.7148713846573, 3839.673627741673, 3879.7284190106984, 3898.766074035567, 1177.4230626992883, 1178.7544727294517, 1184.5202692909386, 1193.3555879824798, 1198.6643739752883, 806.3428305930647, 875.4854102402878, 906.9909300907038, 925.5834874306589, 937.2267878999717, 5580.330360356702, 5669.31968163823, 5869.413058694182, 5903.35063143054, 6055.8486037848525, 437.2719422162128, 443.0629219201366, 455.34203076554724, 455.48985136647167, 456.30413619230274, 3669.1377526281303, 3966.900827479336, 4001.7398869074, 4089.5501494835544, 4093.242750091183, 10353.43056131905, 10849.294795838245, 10858.402787846586, 10876.510557024953, 10895.291806032583, 10397.220208484394, 10559.947200263949, 10746.301490403099, 10796.352218866894, 10818.02637762605, 8172.305354044854, 8242.093369729326, 8268.627911743986, 8298.70954516589, 8353.582320883932, 5432.782688692408, 5493.560515158698, 5744.253247077853, 5856.0, 5959.970200148971, 9234.630614775602, 9454.480003599869, 10084.142847858015, 10089.445080520642, 10146.289759717045, 8512.40413171072, 9262.16640502331, 9897.554610042422, 10284.0, 10419.270651054354, 6833.077534532775, 6939.236683964861, 7026.613536255555, 7075.575465472089, 7084.964575177091, 8231.876521852057, 8268.09051004401, 8353.83292334162, 8391.580420978804, 8392.0, 7485.625718713934, 7537.623118843926, 7562.584057876869, 7601.0, 7701.191374905554, 5902.970485147718, 7382.151052628801, 7383.150937642025, 7413.369863561442, 7413.518121322097, 6824.181098268041, 6957.234704182435, 6966.303369662993, 7037.472189585904, 7041.049458323266, 4685.5782979532005, 4951.0, 4962.578180854668, 4993.201087825931, 5155.510226528474, 4951.306817045544, 5078.060558796635, 5135.948640513547, 5149.9227511586605, 5214.452482489284], "value": 4476.584024165003, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [267.30500698184716, 303.4492396300714, 307.3928990244268, 316.7117922690351, 318.03000847415404, 4518.6954653126895, 4662.997455547057, 4893.510648935105, 5271.262023316739, 5471.151971444422, 4385.232584297743, 4473.66447516436, 5402.189671549269, 5402.702851343174, 5439.573068966555, 3863.9034024149482, 3868.071662800922, 3905.921881562367, 4061.675065994728, 4130.607592278729, 4069.3895915612597, 4078.653314468274, 4084.4690190275223, 4114.979425102885, 4164.229617520753, 3307.619623743264, 3452.7410444216657, 3601.94597081044, 4021.457103291062, 4029.8992525186814, 2686.597010448429, 3474.940143256306, 3816.2367526494813, 3922.2743792398214, 4022.919541609166, 3505.3865573524786, 3513.402721537345, 3523.4714792781288, 3523.6476352364557, 3549.5563054618174, 5212.504812042887, 5239.659422137587, 5263.86840328991, 5280.762365693553, 5339.332583427072, 4397.868063958086, 4633.976830115827, 4643.514075495843, 4675.976620116911, 4694.50707675696, 4737.005228901935, 5335.493128152819, 5409.540189083933, 5595.972020139914, 5597.860053498654, 3906.2773386923227, 3915.6084391560903, 3921.823517941671, 3927.9214415711813, 3951.9604803952166, 4838.516148385169, 5125.949620151931, 5461.208124821918, 5661.716914154317, 5966.791162309299, 3492.965070349315, 3790.962090379116, 3916.941245881314, 3921.2941670499586, 3924.274009308287, 3989.8204580793936, 4016.357382818735, 4023.7786921719003, 4030.1738143680477, 4032.2741906457118, 4078.388241763759, 4347.999960009216, 4669.159551280734, 4673.415823022122, 4709.505501922317, 5243.606729495303, 5464.7814087436855, 5607.663540187602, 5644.8024319148635, 5709.8287051388525, 1354.6748780292855, 1367.7264547090422, 1377.738229736367, 1377.8966577506526, 1383.979240311396, 784.8391079828622, 830.4685001598981, 840.9411341206057, 846.5851732650957, 852.8592782190993, 5110.821121260738, 5183.537819535766, 5238.952209558103, 5343.7862485500145, 5345.251664766935, 4891.364122664031, 5648.74580643872, 5808.199458167982, 5815.156802263648, 5819.53443724501, 4291.875521616757, 4689.859304220879, 4947.876303092379, 5290.68255904647, 5351.892962140813, 2610.2952202905108, 2786.3452088759127, 2906.5349544072847, 3016.8642411091555, 3085.552594873731, 5162.870928226825, 5852.297724273115, 5975.671338076448, 6055.910710804766, 6081.513478921675, 5267.970002947748, 5322.946770532322, 5947.06720315899, 5981.551383646244, 5987.431194036647, 5388.91916621251, 5414.620976531605, 5569.944300557105, 6012.248468941382, 6028.788992385245, 5337.919931200958, 5429.511343979061, 5788.044972579477, 5807.883842323215, 5827.358990511125, 5109.135165664431, 5575.8884822304135, 5779.162021506942, 5800.593958423039, 5827.154078308296, 5072.51811077947, 5839.5912286141265, 6099.394956807582, 6114.737547107598, 6139.969300153471, 3496.3706532823317, 3692.593814680329, 3870.9225815484097, 3886.4753258309765, 3898.2398432305426, 5812.73842677089, 5824.708764561839, 5826.824380712437, 5857.355690873916, 5874.030784920611, 5126.8974620508125, 5320.637077596489, 5657.813218218406, 5669.773209071591, 5717.685527295872, 4937.876553086202, 5434.782608695607, 5510.641808282448, 5653.162722115411, 5656.377798442086, 4642.651801114863, 4789.329493870791, 5457.972710136424, 5540.398740818339, 5569.972150139223, 4730.645201609824, 5095.821646242363, 5524.8342549723575, 5568.048934064952, 5699.178906441338, 4444.666650001198, 4993.9762348717695, 5368.624196306378, 5471.808486703106, 5564.805231816867], "value": 4076.8637477179227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.1266571792374, 661.8279247395678, 670.926198118207, 689.5138927056425, 772.7874834420534, 15041.548753537398, 15194.544163675107, 15776.76334854978, 15829.60425989351, 15944.202789860505, 13982.650433739162, 14112.576622701336, 14260.215688137148, 14260.786088208684, 14261.857381426182, 842.5787106446792, 866.4974314897376, 867.1242045534025, 867.7873920889391, 870.634333579898, 684.8150999230205, 705.048184950318, 850.1286181663813, 872.4721543466206, 887.4763889305309, 920.779013036873, 922.7739203895055, 925.4771054354302, 926.735880274122, 927.7263207353814, 907.9137481939205, 915.3546749541557, 916.1159481100769, 918.3709159225951, 921.2123634292717, 530.3794560364345, 654.5581732330658, 672.8418821576926, 674.7402250133733, 675.7364627795164, 14657.120572765669, 14710.705785884329, 14714.190719510423, 14723.116613003254, 14723.190224537646, 13490.325483725872, 13770.724585508335, 13921.30393480322, 13971.441142354293, 14119.71760564783, 11536.307821530734, 12422.068344874171, 12552.623421297376, 12566.623001309976, 13064.085514014023, 4197.727147735387, 4441.467023957113, 4550.772461376918, 4641.396618439615, 4646.558576935186, 128026.0, 128209.35895320556, 128682.99999999907, 129213.0, 129367.0, 10856.674299771019, 10881.183911206692, 10945.781084378426, 10947.4526273686, 11094.611688590861, 21510.892445537986, 21517.67723484149, 21534.24630137969, 21569.352919412442, 21579.352619421443, 7626.809329766689, 7778.688852445952, 7817.765467035998, 7863.764087077397, 7983.920160798318, 4169.478815148106, 4204.3903633972905, 4259.8083086261195, 4285.5928686774705, 4287.4855017397485, 3359.3449277390673, 3474.4440889457564, 3474.5656792900886, 3476.443768996999, 3478.286951175003, 530.3211888782365, 618.77724019353, 648.3710800523485, 652.083822229768, 653.3368630839701, 511.6162877841619, 567.9716014199273, 590.35356284868, 601.9488343490765, 615.5383462403198, 8185.877211841827, 8747.544645082906, 8839.823203536022, 8936.106389361012, 9008.819823603491, 515.8091506142677, 530.5596355025319, 538.1900240138566, 588.5909293041381, 632.3360471504901, 4182.414461975326, 4309.245881970643, 4366.978165109154, 4378.343248512749, 4417.823287068545, 92475.5376223128, 108524.0, 153991.0, 157568.0, 159066.0, 128948.0, 134478.0, 138643.61356386307, 140329.0, 144784.0, 102504.0, 104606.0, 105338.94661053445, 115306.42346788212, 120440.79559204471, 8714.25928796034, 9775.169110625677, 9845.556949937414, 9870.259730520384, 10034.448105353984, 48807.0, 55030.44969550413, 60025.794325248375, 62662.686686566274, 63649.6817515928, 82835.5858220705, 90830.0, 91383.0, 92180.0, 93653.0, 13040.152390094614, 13093.869061309266, 13233.536826211037, 13367.264800436069, 13393.464261429433, 14728.189949552878, 15318.846811531743, 15380.38478460849, 15381.30784114695, 15566.688666226839, 12390.380480976095, 13123.803142953055, 13611.591652250449, 14016.859831401556, 14484.203368814817, 13771.380287886868, 13780.862191378359, 13794.37925293344, 13977.301134943416, 14117.43530258778, 11268.605598804003, 13419.210417176764, 13551.457941682222, 13632.795508067189, 13814.930925345308, 11245.269057511563, 11428.428578571204, 11431.542738290374, 11570.19008669385, 11583.884161158281, 10322.587096516356, 11135.55457781712, 11315.490802913724, 11414.543418263176, 11419.31484110956], "value": 7768.5858337730215, "unit": "score"}], "name": "dromaeo_css", "value": 7394.982083021908, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 116.0, 113.0, 110.0, 112.0, 112.0, 111.0, 113.0, 123.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 114.0, 128.0, 164.0, 108.0, 130.0, 129.0, 108.0, 162.0, 108.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 185.0, 183.0, 185.0, 184.0, 183.0, 182.0, 185.0, 184.0], "value": 184.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 158.0, 60.0, 49.0, 46.0, 68.0, 134.0, 73.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 70.0, 70.0, 72.0, 151.0, 97.0, 100.0, 121.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 83.0, 86.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 124.0, 94.0, 96.0, 96.0, 96.0, 96.0, 95.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 85.0, 85.0, 84.0, 83.0, 84.0, 83.0, 93.0, 129.0], "value": 89.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 55.0, 54.0, 55.0, 52.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 110.0, 118.0, 85.0, 77.0, 73.0, 73.0, 71.0, 72.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 85.0, 88.0, 87.0, 84.0, 87.0, 89.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 137.0, 139.0, 140.0, 138.0, 141.0, 134.0, 183.0, 141.0], "value": 143.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 174.0, 184.0, 175.0, 170.0, 172.0, 174.0, 174.0, 173.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 67.0, 68.0, 70.0, 68.0, 69.0, 66.0, 67.0, 69.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1490.3000000000002, "alertThreshold": 2.0}]} 08:03:43 INFO - Return code: 0 08:03:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:03:43 INFO - # TBPL SUCCESS # 08:03:43 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:03:43 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:03:43 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:03:43 INFO - 2016-09-01 08:03:43.884 screenresolution[6786:166980] starting screenresolution argv=screenresolution get 08:03:43 INFO - 2016-09-01 08:03:43.887 screenresolution[6786:166980] Display 0: 1600x1200x32@60 08:03:43 INFO - 2016-09-01 08:03:43.893 screenresolution[6787:166983] starting screenresolution argv=screenresolution list 08:03:43 INFO - Available Modes on Display 0 08:03:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:03:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:03:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:03:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:03:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:03:44 INFO - Intel Iris: 08:03:44 INFO - Chipset Model: Intel Iris 08:03:44 INFO - Type: GPU 08:03:44 INFO - Bus: Built-In 08:03:44 INFO - VRAM (Dynamic, Max): 1536 MB 08:03:44 INFO - Vendor: Intel (0x8086) 08:03:44 INFO - Device ID: 0x0a2e 08:03:44 INFO - Revision ID: 0x0009 08:03:44 INFO - Displays: 08:03:44 INFO - Display: 08:03:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:03:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:03:44 INFO - Display Serial Number: 1600x1200 60 08:03:44 INFO - Main Display: Yes 08:03:44 INFO - Mirror: Off 08:03:44 INFO - Online: Yes 08:03:44 INFO - Rotation: Supported 08:03:44 INFO - Return code: 0 08:03:44 INFO - Running post-action listener: _resource_record_post_action 08:03:44 INFO - [mozharness: 2016-09-01 15:03:44.133055Z] Finished run-tests step (success) 08:03:44 INFO - Running post-run listener: _resource_record_post_run 08:03:44 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 512; Write bytes: 705964544; Read time: 1; Write time: 1916 08:03:44 INFO - TinderboxPrint: CPU usage
53.6% 08:03:44 INFO - TinderboxPrint: I/O read bytes / time
512 / 1 08:03:44 INFO - TinderboxPrint: I/O write bytes / time
705,964,544 / 1,916 08:03:44 INFO - TinderboxPrint: CPU idle
2,254.3 (46.4%) 08:03:44 INFO - TinderboxPrint: CPU system
973.2 (20.1%) 08:03:44 INFO - TinderboxPrint: CPU user
1,626.1 (33.5%) 08:03:44 INFO - TinderboxPrint: Swap in / out
405,454,848 / 0 08:03:44 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 398637568; Write bytes: 393738240; Read time: 29611; Write time: 764 08:03:44 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 0; Write bytes: 295563776; Read time: 0; Write time: 1116 08:03:44 INFO - Running post-run listener: _upload_blobber_files 08:03:44 INFO - Blob upload gear active. 08:03:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:03:44 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 08:03:44 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:03:44 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:03:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:03:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:45 INFO - (blobuploader) - INFO - Done attempting. 08:03:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:03:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:03:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:46 INFO - (blobuploader) - INFO - Done attempting. 08:03:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:03:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:03:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:03:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:03:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:03:50 INFO - (blobuploader) - INFO - Done attempting. 08:03:50 INFO - (blobuploader) - INFO - Iteration through files over. 08:03:50 INFO - Return code: 0 08:03:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:03:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:03:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85709b086b056606c305e614de0de33a487feb53fd7a8d0a069fefa87b007dcdfde6beb110969c2f105d146874950ce74a50d42ecd0da41afd2c6eb52b9e3475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/802d12974068bd38d01d2d90236467bc44694848364a581494141b449d915592a855b98d33814900a4f9060de18ee7f67e7a85ec237b2fa1a90ef578982ef71d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04fc1f64be727cb150d9e822de22d732e1aa12651745bdde5a75dba657dcaaf37510b20ec7ce63d28d0fc7a499da5daeac33fc68d39e4959ff3cbad85378382"} 08:03:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:03:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:03:50 INFO - Contents: 08:03:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85709b086b056606c305e614de0de33a487feb53fd7a8d0a069fefa87b007dcdfde6beb110969c2f105d146874950ce74a50d42ecd0da41afd2c6eb52b9e3475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/802d12974068bd38d01d2d90236467bc44694848364a581494141b449d915592a855b98d33814900a4f9060de18ee7f67e7a85ec237b2fa1a90ef578982ef71d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04fc1f64be727cb150d9e822de22d732e1aa12651745bdde5a75dba657dcaaf37510b20ec7ce63d28d0fc7a499da5daeac33fc68d39e4959ff3cbad85378382"} 08:03:50 INFO - Running post-run listener: copy_logs_to_upload_dir 08:03:50 INFO - Copying logs to upload dir... 08:03:50 INFO - mkdir: /builds/slave/test/build/upload/logs 08:03:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.710289 ========= master_lag: 63.49 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 17 secs) (at 2016-09-01 08:04:53.610218) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-09-01 08:04:53.615052) ========= 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.3oP8aOOaED/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.a9MJOVn858/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85709b086b056606c305e614de0de33a487feb53fd7a8d0a069fefa87b007dcdfde6beb110969c2f105d146874950ce74a50d42ecd0da41afd2c6eb52b9e3475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/802d12974068bd38d01d2d90236467bc44694848364a581494141b449d915592a855b98d33814900a4f9060de18ee7f67e7a85ec237b2fa1a90ef578982ef71d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04fc1f64be727cb150d9e822de22d732e1aa12651745bdde5a75dba657dcaaf37510b20ec7ce63d28d0fc7a499da5daeac33fc68d39e4959ff3cbad85378382"} build_url:https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011437 build_url: 'https://queue.taskcluster.net/v1/task/A810zQojRJ6SJiEy9ph0iw/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/85709b086b056606c305e614de0de33a487feb53fd7a8d0a069fefa87b007dcdfde6beb110969c2f105d146874950ce74a50d42ecd0da41afd2c6eb52b9e3475", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/802d12974068bd38d01d2d90236467bc44694848364a581494141b449d915592a855b98d33814900a4f9060de18ee7f67e7a85ec237b2fa1a90ef578982ef71d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d04fc1f64be727cb150d9e822de22d732e1aa12651745bdde5a75dba657dcaaf37510b20ec7ce63d28d0fc7a499da5daeac33fc68d39e4959ff3cbad85378382"}' ========= master_lag: 6.91 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 6 secs) (at 2016-09-01 08:05:00.538687) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-09-01 08:05:00.538978) ========= 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.3oP8aOOaED/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.a9MJOVn858/Listeners TMPDIR=/var/folders/qg/7pj314vs6ns665sg_7g6q8x000000w/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.004786 ========= master_lag: 5.26 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 5 secs) (at 2016-09-01 08:05:05.802228) ========= ========= Started reboot skipped (results: 3, elapsed: 3 secs) (at 2016-09-01 08:05:05.802511) ========= ========= Finished reboot skipped (results: 3, elapsed: 3 secs) (at 2016-09-01 08:05:09.724943) ========= ========= Total master_lag: 75.74 =========