builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1471495167.53 results: success (0) buildid: 20160817174714 builduid: 67e56ec9b9ce46d6b3f730c0aea653bf revision: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:27.527892) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:27.528380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:27.528720) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:27.556029) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-17 21:39:27.556703) ========= 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.thzEs3QGa3/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.acV8jGuAxV/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-08-17 21:39:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.1M=0.001s 2016-08-17 21:39:27 (20.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128187 ========= master_lag: 2.71 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-08-17 21:39:30.397199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:30.397539) ========= 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.thzEs3QGa3/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.acV8jGuAxV/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.020703 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:30.464734) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-17 21:39:30.465075) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce --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 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.thzEs3QGa3/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.acV8jGuAxV/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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-08-17 21:39:30,539 truncating revision to first 12 chars 2016-08-17 21:39:30,539 Setting DEBUG logging. 2016-08-17 21:39:30,539 attempt 1/10 2016-08-17 21:39:30,539 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3ebc785598ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 21:39:31,820 unpacking tar archive at: fx-team-3ebc785598ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549218 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-17 21:39:32.133304) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:32.133651) ========= script_repo_revision: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:32.134044) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:32.134331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 21:39:32.153702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-17 21:39:32.154369) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.thzEs3QGa3/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.acV8jGuAxV/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:39:32 INFO - MultiFileLogger online at 20160817 21:39:32 in /builds/slave/test 21:39:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:39:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:39:32 INFO - {'append_to_log': False, 21:39:32 INFO - 'base_work_dir': '/builds/slave/test', 21:39:32 INFO - 'blob_upload_branch': 'Fx-Team', 21:39:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:39:32 INFO - 'branch': 'Fx-Team', 21:39:32 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:32 INFO - 'config_files': ('talos/mac_config.py',), 21:39:32 INFO - 'default_actions': ('clobber', 21:39:32 INFO - 'read-buildbot-config', 21:39:32 INFO - 'download-and-extract', 21:39:32 INFO - 'populate-webroot', 21:39:32 INFO - 'create-virtualenv', 21:39:32 INFO - 'install', 21:39:32 INFO - 'run-tests'), 21:39:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:32 INFO - 'download_minidump_stackwalk': True, 21:39:32 INFO - 'download_symbols': 'ondemand', 21:39:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:32 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:32 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:32 INFO - 'installer_path': 'installer.exe', 21:39:32 INFO - 'log_level': 'info', 21:39:32 INFO - 'log_name': 'talos', 21:39:32 INFO - 'log_to_console': True, 21:39:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:39:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:39:32 INFO - 'opt_config_files': (), 21:39:32 INFO - 'pip_index': False, 21:39:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:39:32 INFO - 'cmd': ('bash', 21:39:32 INFO - '-c', 21:39:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:39:32 INFO - 'enabled': True, 21:39:32 INFO - 'halt_on_failure': False, 21:39:32 INFO - 'name': 'check_screen_resolution'},), 21:39:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:39:32 INFO - 'cmd': ('bash', 21:39:32 INFO - '-c', 21:39:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:39:32 INFO - 'enabled': True, 21:39:32 INFO - 'halt_on_failure': False, 21:39:32 INFO - 'name': 'check_screen_resolution'},), 21:39:32 INFO - 'run_cmd_checks_enabled': True, 21:39:32 INFO - 'sps_profile': False, 21:39:32 INFO - 'sps_profile_interval': 0, 21:39:32 INFO - 'suite': 'dromaeojs-e10s', 21:39:32 INFO - 'system_bits': '32', 21:39:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:32 INFO - 'title': 't-yosemite-r7-0072', 21:39:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:32 INFO - 'use_talos_json': True, 21:39:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:39:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:32 INFO - 'work_dir': 'build'} 21:39:32 INFO - [mozharness: 2016-08-18 04:39:32.352419Z] Running clobber step. 21:39:32 INFO - Running pre-action listener: _resource_record_pre_action 21:39:32 INFO - Running main action method: clobber 21:39:32 INFO - rmtree: /builds/slave/test/build 21:39:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:39:33 INFO - Running post-action listener: _resource_record_post_action 21:39:33 INFO - [mozharness: 2016-08-18 04:39:33.874693Z] Finished clobber step (success) 21:39:33 INFO - [mozharness: 2016-08-18 04:39:33.874829Z] Running read-buildbot-config step. 21:39:33 INFO - Running pre-action listener: _resource_record_pre_action 21:39:33 INFO - Running main action method: read_buildbot_config 21:39:33 INFO - Using buildbot properties: 21:39:33 INFO - { 21:39:33 INFO - "project": "", 21:39:33 INFO - "product": "firefox", 21:39:33 INFO - "script_repo_revision": "production", 21:39:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 21:39:33 INFO - "repository": "", 21:39:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 21:39:33 INFO - "buildid": "20160817174714", 21:39:33 INFO - "pgo_build": "False", 21:39:33 INFO - "basedir": "/builds/slave/test", 21:39:33 INFO - "buildnumber": 93, 21:39:33 INFO - "slavename": "t-yosemite-r7-0072", 21:39:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 21:39:33 INFO - "platform": "yosemite_r7", 21:39:33 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 21:39:33 INFO - "branch": "fx-team", 21:39:33 INFO - "repo_path": "integration/fx-team", 21:39:33 INFO - "revision": "3ebc785598eee4e31ff83b7cb859cb5b9c9147ce", 21:39:33 INFO - "stage_platform": "macosx64", 21:39:33 INFO - "builduid": "67e56ec9b9ce46d6b3f730c0aea653bf", 21:39:33 INFO - "slavebuilddir": "test" 21:39:33 INFO - } 21:39:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 21:39:33 INFO - Running post-action listener: _resource_record_post_action 21:39:33 INFO - [mozharness: 2016-08-18 04:39:33.877828Z] Finished read-buildbot-config step (success) 21:39:33 INFO - [mozharness: 2016-08-18 04:39:33.877950Z] Running download-and-extract step. 21:39:33 INFO - Running pre-action listener: _resource_record_pre_action 21:39:33 INFO - Running main action method: download_and_extract 21:39:33 INFO - mkdir: /builds/slave/test/build/tests 21:39:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:33 INFO - trying https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 21:39:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:35 INFO - Downloaded 1199 bytes. 21:39:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 21:39:35 INFO - Using the following test package requirements: 21:39:35 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:39:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 21:39:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 21:39:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'jsshell-mac.zip'], 21:39:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 21:39:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 21:39:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 21:39:35 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 21:39:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 21:39:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 21:39:35 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 21:39:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:39:35 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')]} 21:39:35 INFO - trying https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:39:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:36 INFO - Downloaded 16339509 bytes. 21:39:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:39:43 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 21:39:43 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')]} 21:39:43 INFO - trying https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 21:39:43 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:43 INFO - Downloaded 16339509 bytes. 21:39:43 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 21:39:50 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')]} 21:39:50 INFO - trying https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 21:39:50 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:51 INFO - Downloaded 14413981 bytes. 21:39:51 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 21:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:51 INFO - trying https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:39:51 INFO - Downloading https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 21:39:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/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 21:39:54 INFO - Downloaded 111292824 bytes. 21:39:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:39:54 INFO - mkdir: /builds/slave/test/properties 21:39:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:39:54 INFO - Writing to file /builds/slave/test/properties/build_url 21:39:54 INFO - Contents: 21:39:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 21:39:55 INFO - Running post-action listener: _resource_record_post_action 21:39:55 INFO - Running post-action listener: set_extra_try_arguments 21:39:55 INFO - [mozharness: 2016-08-18 04:39:55.119570Z] Finished download-and-extract step (success) 21:39:55 INFO - [mozharness: 2016-08-18 04:39:55.119667Z] Running populate-webroot step. 21:39:55 INFO - Running pre-action listener: _resource_record_pre_action 21:39:55 INFO - Running main action method: populate_webroot 21:39:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:39:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:39:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:39:55 INFO - '--tppagecycles', 21:39:55 INFO - '7'], 21:39:55 INFO - 'tests': ['tsvgm']}}, 21:39:55 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:39:55 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:39:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:39:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:39:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:39:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['damp', 'tps']}, 21:39:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'tests': ['damp', 'tps']}, 21:39:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['dromaeo_dom']}, 21:39:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:39:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['basic_compositor_video']}, 21:39:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:39:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['a11yr', 21:39:55 INFO - 'ts_paint', 21:39:55 INFO - 'tpaint', 21:39:55 INFO - 'sessionrestore', 21:39:55 INFO - 'sessionrestore_no_auto_restore', 21:39:55 INFO - 'tabpaint']}, 21:39:55 INFO - 'other-e10s': {'tests': ['a11yr', 21:39:55 INFO - 'ts_paint', 21:39:55 INFO - 'tpaint', 21:39:55 INFO - 'sessionrestore', 21:39:55 INFO - 'sessionrestore_no_auto_restore', 21:39:55 INFO - 'tabpaint']}, 21:39:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:39:55 INFO - 'ts_paint', 21:39:55 INFO - 'tpaint', 21:39:55 INFO - 'sessionrestore', 21:39:55 INFO - 'sessionrestore_no_auto_restore', 21:39:55 INFO - 'tabpaint']}, 21:39:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:39:55 INFO - 'ts_paint', 21:39:55 INFO - 'tpaint', 21:39:55 INFO - 'sessionrestore', 21:39:55 INFO - 'sessionrestore_no_auto_restore', 21:39:55 INFO - 'tabpaint']}, 21:39:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['a11yr', 21:39:55 INFO - 'ts_paint', 21:39:55 INFO - 'tpaint', 21:39:55 INFO - 'sessionrestore', 21:39:55 INFO - 'sessionrestore_no_auto_restore', 21:39:55 INFO - 'tabpaint']}, 21:39:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['a11yr', 21:39:55 INFO - 'ts_paint', 21:39:55 INFO - 'tpaint', 21:39:55 INFO - 'sessionrestore', 21:39:55 INFO - 'sessionrestore_no_auto_restore', 21:39:55 INFO - 'tabpaint']}, 21:39:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['tsvgx', 21:39:55 INFO - 'tsvgr_opacity', 21:39:55 INFO - 'tart', 21:39:55 INFO - 'tscrollx', 21:39:55 INFO - 'cart']}, 21:39:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:39:55 INFO - 'tsvgr_opacity', 21:39:55 INFO - 'tart', 21:39:55 INFO - 'tscrollx', 21:39:55 INFO - 'cart']}, 21:39:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'talos_options': ['--disable-e10s'], 21:39:55 INFO - 'tests': ['tp5o']}, 21:39:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'tests': ['tp5o']}, 21:39:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'talos_options': ['--disable-e10s', 21:39:55 INFO - '--xperf_path', 21:39:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:55 INFO - 'tests': ['tp5n']}, 21:39:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:39:55 INFO - 'talos_options': ['--xperf_path', 21:39:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:39:55 INFO - 'tests': ['tp5n']}}, 21:39:55 INFO - 'talos.zip': {'path': '', 21:39:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:39:55 INFO - Running post-action listener: _resource_record_post_action 21:39:55 INFO - [mozharness: 2016-08-18 04:39:55.137893Z] Finished populate-webroot step (success) 21:39:55 INFO - [mozharness: 2016-08-18 04:39:55.137977Z] Running create-virtualenv step. 21:39:55 INFO - Running pre-action listener: _resource_record_pre_action 21:39:55 INFO - Running main action method: create_virtualenv 21:39:55 INFO - Creating virtualenv /builds/slave/test/build/venv 21:39:55 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 21:39:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:39:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:39:55 INFO - Using real prefix '/tools/python27' 21:39:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:39:55 INFO - Installing distribute.............................................................................................................................................................................................done. 21:39:58 INFO - Installing pip.................done. 21:39:58 INFO - Return code: 0 21:39:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:58 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:39:58 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 21:39:58 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 21:39:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:39:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:39:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:39:58 INFO - 'HOME': '/Users/cltbld', 21:39:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:39:58 INFO - 'LOGNAME': 'cltbld', 21:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:58 INFO - 'MOZ_NO_REMOTE': '1', 21:39:58 INFO - 'NO_EM_RESTART': '1', 21:39:58 INFO - 'PAGER': '/bin/cat', 21:39:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:58 INFO - 'PWD': '/builds/slave/test', 21:39:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:39:58 INFO - 'SHELL': '/bin/bash', 21:39:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:39:58 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:39:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:39:58 INFO - 'USER': 'cltbld', 21:39:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:39:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:58 INFO - 'XPC_FLAGS': '0x0', 21:39:58 INFO - 'XPC_SERVICE_NAME': '0', 21:39:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:59 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 21:39:59 INFO - Cleaning up... 21:39:59 INFO - Return code: 0 21:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:39:59 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')]} 21:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:59 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')]} 21:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:39:59 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:39:59 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 21:39:59 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 21:39:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:39:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:39:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:39:59 INFO - 'HOME': '/Users/cltbld', 21:39:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:39:59 INFO - 'LOGNAME': 'cltbld', 21:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:39:59 INFO - 'MOZ_NO_REMOTE': '1', 21:39:59 INFO - 'NO_EM_RESTART': '1', 21:39:59 INFO - 'PAGER': '/bin/cat', 21:39:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:39:59 INFO - 'PWD': '/builds/slave/test', 21:39:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:39:59 INFO - 'SHELL': '/bin/bash', 21:39:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:39:59 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:39:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:39:59 INFO - 'USER': 'cltbld', 21:39:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:39:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:39:59 INFO - 'XPC_FLAGS': '0x0', 21:39:59 INFO - 'XPC_SERVICE_NAME': '0', 21:39:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:39:59 INFO - Downloading/unpacking psutil>=3.1.1 21:39:59 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 21:39:59 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 21:39:59 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 21:39:59 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 21:39:59 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 21:39:59 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 21:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:02 INFO - Installing collected packages: psutil 21:40:02 INFO - Running setup.py install for psutil 21:40:02 INFO - building 'psutil._psutil_osx' extension 21:40:02 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 21:40:02 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 21:40:02 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 21:40:02 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 21:40:02 INFO - building 'psutil._psutil_posix' extension 21:40:02 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 21:40:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:40:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:40:03 INFO - ^ 21:40:03 INFO - 1 warning generated. 21:40:03 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 21:40:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:03 INFO - Successfully installed psutil 21:40:03 INFO - Cleaning up... 21:40:03 INFO - Return code: 0 21:40:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:40: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 mozsystemmonitor==0.3 21:40:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:03 INFO - 'HOME': '/Users/cltbld', 21:40:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:03 INFO - 'LOGNAME': 'cltbld', 21:40:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:03 INFO - 'MOZ_NO_REMOTE': '1', 21:40:03 INFO - 'NO_EM_RESTART': '1', 21:40:03 INFO - 'PAGER': '/bin/cat', 21:40:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:03 INFO - 'PWD': '/builds/slave/test', 21:40:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:03 INFO - 'SHELL': '/bin/bash', 21:40:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:03 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:03 INFO - 'USER': 'cltbld', 21:40:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:03 INFO - 'XPC_FLAGS': '0x0', 21:40:03 INFO - 'XPC_SERVICE_NAME': '0', 21:40:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:40:03 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 21:40:03 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 21:40:03 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 21:40:03 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 21:40:03 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 21:40:03 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 21:40:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:40:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:40:06 INFO - Installing collected packages: mozsystemmonitor 21:40:06 INFO - Running setup.py install for mozsystemmonitor 21:40:06 INFO - Successfully installed mozsystemmonitor 21:40:06 INFO - Cleaning up... 21:40:06 INFO - Return code: 0 21:40:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:06 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:06 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 21:40:06 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 21:40:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:06 INFO - 'HOME': '/Users/cltbld', 21:40:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:06 INFO - 'LOGNAME': 'cltbld', 21:40:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:06 INFO - 'MOZ_NO_REMOTE': '1', 21:40:06 INFO - 'NO_EM_RESTART': '1', 21:40:06 INFO - 'PAGER': '/bin/cat', 21:40:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:06 INFO - 'PWD': '/builds/slave/test', 21:40:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:06 INFO - 'SHELL': '/bin/bash', 21:40:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:06 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:06 INFO - 'USER': 'cltbld', 21:40:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:06 INFO - 'XPC_FLAGS': '0x0', 21:40:06 INFO - 'XPC_SERVICE_NAME': '0', 21:40:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:06 INFO - Downloading/unpacking jsonschema==2.5.1 21:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:40:09 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 21:40:09 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 21:40:09 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 21:40:09 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 21:40:09 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 21:40:09 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 21:40:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:09 INFO - warning: no files found matching '*.txt' 21:40:09 INFO - no previously-included directories found matching 'build' 21:40:09 INFO - no previously-included directories found matching 'dist' 21:40:09 INFO - no previously-included directories found matching '.git*' 21:40:09 INFO - Installing collected packages: jsonschema, functools32 21:40:09 INFO - Running setup.py install for functools32 21:40:09 INFO - warning: no files found matching '*.txt' 21:40:09 INFO - no previously-included directories found matching 'build' 21:40:09 INFO - no previously-included directories found matching 'dist' 21:40:09 INFO - no previously-included directories found matching '.git*' 21:40:09 INFO - Successfully installed jsonschema functools32 21:40:09 INFO - Cleaning up... 21:40:09 INFO - Return code: 0 21:40:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:40:09 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')]} 21:40:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:09 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')]} 21:40:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:09 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:09 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 21:40:09 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 21:40:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:09 INFO - 'HOME': '/Users/cltbld', 21:40:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:09 INFO - 'LOGNAME': 'cltbld', 21:40:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:09 INFO - 'MOZ_NO_REMOTE': '1', 21:40:09 INFO - 'NO_EM_RESTART': '1', 21:40:09 INFO - 'PAGER': '/bin/cat', 21:40:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:09 INFO - 'PWD': '/builds/slave/test', 21:40:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:09 INFO - 'SHELL': '/bin/bash', 21:40:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:09 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:09 INFO - 'USER': 'cltbld', 21:40:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:09 INFO - 'XPC_FLAGS': '0x0', 21:40:09 INFO - 'XPC_SERVICE_NAME': '0', 21:40:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:40:10 INFO - Cleaning up... 21:40:10 INFO - Return code: 0 21:40:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:40:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:10 INFO - 'HOME': '/Users/cltbld', 21:40:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:10 INFO - 'LOGNAME': 'cltbld', 21:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:10 INFO - 'MOZ_NO_REMOTE': '1', 21:40:10 INFO - 'NO_EM_RESTART': '1', 21:40:10 INFO - 'PAGER': '/bin/cat', 21:40:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:10 INFO - 'PWD': '/builds/slave/test', 21:40:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:10 INFO - 'SHELL': '/bin/bash', 21:40:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:10 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:10 INFO - 'USER': 'cltbld', 21:40:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:10 INFO - 'XPC_FLAGS': '0x0', 21:40:10 INFO - 'XPC_SERVICE_NAME': '0', 21:40:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:10 INFO - Downloading/unpacking blobuploader==1.2.4 21:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:12 INFO - Downloading blobuploader-1.2.4.tar.gz 21:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:40:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:40:12 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 21:40:12 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 21:40:12 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 21:40:12 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 21:40:12 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 21:40:12 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 21:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:40:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:13 INFO - Downloading docopt-0.6.1.tar.gz 21:40:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:40:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:40:14 INFO - Running setup.py install for blobuploader 21:40:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:40:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:40:14 INFO - Running setup.py install for requests 21:40:14 INFO - Running setup.py install for docopt 21:40:14 INFO - Successfully installed blobuploader requests docopt 21:40:14 INFO - Cleaning up... 21:40:14 INFO - Return code: 0 21:40:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:14 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:14 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 21:40:14 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 21:40:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:14 INFO - 'HOME': '/Users/cltbld', 21:40:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:14 INFO - 'LOGNAME': 'cltbld', 21:40:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:14 INFO - 'MOZ_NO_REMOTE': '1', 21:40:14 INFO - 'NO_EM_RESTART': '1', 21:40:14 INFO - 'PAGER': '/bin/cat', 21:40:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:14 INFO - 'PWD': '/builds/slave/test', 21:40:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:14 INFO - 'SHELL': '/bin/bash', 21:40:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:14 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:14 INFO - 'USER': 'cltbld', 21:40:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:14 INFO - 'XPC_FLAGS': '0x0', 21:40:14 INFO - 'XPC_SERVICE_NAME': '0', 21:40:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-0QsYQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Xm381J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-xy6QaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-IZnkS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-sjLpQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-1ia0j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-GwK4l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-UcTgrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:15 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-zlemby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-_txT9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-uoa9Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-AMQfnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Q56NFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-90stfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-DOUxGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Sflfl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:16 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-k0YXSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:40:16 INFO - Running setup.py install for manifestparser 21:40:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:40:17 INFO - Running setup.py install for mozcrash 21:40:17 INFO - Running setup.py install for mozdebug 21:40:17 INFO - Running setup.py install for mozdevice 21:40:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:40:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:40:17 INFO - Running setup.py install for mozfile 21:40:17 INFO - Running setup.py install for mozhttpd 21:40:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:40:17 INFO - Running setup.py install for mozinfo 21:40:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:40:17 INFO - Running setup.py install for mozInstall 21:40:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Running setup.py install for mozleak 21:40:18 INFO - Running setup.py install for mozlog 21:40:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Running setup.py install for moznetwork 21:40:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Running setup.py install for mozprocess 21:40:18 INFO - Running setup.py install for mozprofile 21:40:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:40:18 INFO - Running setup.py install for mozrunner 21:40:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:40:19 INFO - Running setup.py install for mozscreenshot 21:40:19 INFO - Running setup.py install for moztest 21:40:19 INFO - Running setup.py install for mozversion 21:40:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:40:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:40:19 INFO - Cleaning up... 21:40:19 INFO - Return code: 0 21:40:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:19 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')]} 21:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:19 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')]} 21:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:19 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:19 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 21:40:19 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 21:40:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:19 INFO - 'HOME': '/Users/cltbld', 21:40:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:19 INFO - 'LOGNAME': 'cltbld', 21:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:19 INFO - 'MOZ_NO_REMOTE': '1', 21:40:19 INFO - 'NO_EM_RESTART': '1', 21:40:19 INFO - 'PAGER': '/bin/cat', 21:40:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:19 INFO - 'PWD': '/builds/slave/test', 21:40:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:19 INFO - 'SHELL': '/bin/bash', 21:40:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:19 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:19 INFO - 'USER': 'cltbld', 21:40:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:19 INFO - 'XPC_FLAGS': '0x0', 21:40:19 INFO - 'XPC_SERVICE_NAME': '0', 21:40:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-v49Na7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:19 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)) 21:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:19 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-6DMrIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:19 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)) 21:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-X0JFo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Zdd0E4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-QReWRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-tO4F_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-iTZvUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-QlLZWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Sb_tEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-vzZ2EL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-BSftId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:20 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)) 21:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:20 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-N1wMm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:21 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)) 21:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:21 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-T730ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:21 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)) 21:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:21 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-AL7U8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:21 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)) 21:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:21 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-dLWnXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:21 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)) 21:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:21 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7euQeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:21 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)) 21:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:21 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-X_wZND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:21 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)) 21:40:21 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)) 21:40:21 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)) 21:40:21 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)) 21:40:21 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)) 21:40:21 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)) 21:40:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:24 INFO - Downloading blessings-1.6.tar.gz 21:40:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:40:24 INFO - Installing collected packages: blessings 21:40:24 INFO - Running setup.py install for blessings 21:40:24 INFO - Successfully installed blessings 21:40:24 INFO - Cleaning up... 21:40:24 INFO - Return code: 0 21:40:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:24 INFO - Reading from file tmpfile_stdout 21:40:24 INFO - Current package versions: 21:40:24 INFO - blessings == 1.6 21:40:24 INFO - blobuploader == 1.2.4 21:40:24 INFO - docopt == 0.6.1 21:40:24 INFO - functools32 == 3.2.3-2 21:40:24 INFO - jsonschema == 2.5.1 21:40:24 INFO - manifestparser == 1.1 21:40:24 INFO - mozInstall == 1.12 21:40:24 INFO - mozcrash == 0.17 21:40:24 INFO - mozdebug == 0.1 21:40:24 INFO - mozdevice == 0.48 21:40:24 INFO - mozfile == 1.2 21:40:24 INFO - mozhttpd == 0.7 21:40:24 INFO - mozinfo == 0.9 21:40:24 INFO - mozleak == 0.1 21:40:24 INFO - mozlog == 3.3 21:40:24 INFO - moznetwork == 0.27 21:40:24 INFO - mozprocess == 0.23 21:40:24 INFO - mozprofile == 0.28 21:40:24 INFO - mozrunner == 6.12 21:40:24 INFO - mozscreenshot == 0.1 21:40:24 INFO - mozsystemmonitor == 0.3 21:40:24 INFO - moztest == 0.7 21:40:24 INFO - mozversion == 1.4 21:40:24 INFO - psutil == 3.1.1 21:40:24 INFO - requests == 1.2.3 21:40:24 INFO - wsgiref == 0.1.2 21:40:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:25 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')]} 21:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:25 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:25 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 21:40:25 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 21:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:25 INFO - 'HOME': '/Users/cltbld', 21:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:25 INFO - 'LOGNAME': 'cltbld', 21:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:25 INFO - 'MOZ_NO_REMOTE': '1', 21:40:25 INFO - 'NO_EM_RESTART': '1', 21:40:25 INFO - 'PAGER': '/bin/cat', 21:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:25 INFO - 'PWD': '/builds/slave/test', 21:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:25 INFO - 'SHELL': '/bin/bash', 21:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:25 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:25 INFO - 'USER': 'cltbld', 21:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:25 INFO - 'XPC_FLAGS': '0x0', 21:40:25 INFO - 'XPC_SERVICE_NAME': '0', 21:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 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)) 21:40:25 INFO - Cleaning up... 21:40:25 INFO - Return code: 0 21:40:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:40:25 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')]} 21:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:25 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')]} 21:40:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:25 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 0x103aefa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b84618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8743cb81f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, '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.thzEs3QGa3/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.acV8jGuAxV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 21:40:25 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 21:40:25 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 21:40:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:40:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:40:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:40:25 INFO - 'HOME': '/Users/cltbld', 21:40:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:40:25 INFO - 'LOGNAME': 'cltbld', 21:40:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:25 INFO - 'MOZ_NO_REMOTE': '1', 21:40:25 INFO - 'NO_EM_RESTART': '1', 21:40:25 INFO - 'PAGER': '/bin/cat', 21:40:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:40:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:25 INFO - 'PWD': '/builds/slave/test', 21:40:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:40:25 INFO - 'SHELL': '/bin/bash', 21:40:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:40:25 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:40:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:40:25 INFO - 'USER': 'cltbld', 21:40:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:40:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:40:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:25 INFO - 'XPC_FLAGS': '0x0', 21:40:25 INFO - 'XPC_SERVICE_NAME': '0', 21:40:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:40:25 INFO - Cleaning up... 21:40:25 INFO - Return code: 0 21:40:25 INFO - Running post-action listener: _resource_record_post_action 21:40:25 INFO - Running post-action listener: _start_resource_monitoring 21:40:25 INFO - Starting resource monitoring. 21:40:25 INFO - [mozharness: 2016-08-18 04:40:25.631767Z] Finished create-virtualenv step (success) 21:40:25 INFO - [mozharness: 2016-08-18 04:40:25.632847Z] Running install step. 21:40:25 INFO - Running pre-action listener: _resource_record_pre_action 21:40:25 INFO - Running main action method: install 21:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:25 INFO - Reading from file tmpfile_stdout 21:40:25 INFO - Detecting whether we're running mozinstall >=1.0... 21:40:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:40:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:40:25 INFO - Reading from file tmpfile_stdout 21:40:25 INFO - Output received: 21:40:25 INFO - Usage: mozinstall [options] installer 21:40:25 INFO - Options: 21:40:25 INFO - -h, --help show this help message and exit 21:40:25 INFO - -d DEST, --destination=DEST 21:40:25 INFO - Directory to install application into. [default: 21:40:25 INFO - "/builds/slave/test"] 21:40:25 INFO - --app=APP Application being installed. [default: firefox] 21:40:25 INFO - mkdir: /builds/slave/test/build/application 21:40:25 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'] 21:40:25 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 21:40:59 INFO - Reading from file tmpfile_stdout 21:40:59 INFO - Output received: 21:40:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:40:59 INFO - Running post-action listener: _resource_record_post_action 21:40:59 INFO - [mozharness: 2016-08-18 04:40:59.951253Z] Finished install step (success) 21:40:59 INFO - [mozharness: 2016-08-18 04:40:59.951390Z] Running run-tests step. 21:40:59 INFO - Running pre-action listener: _resource_record_pre_action 21:40:59 INFO - Running main action method: run_tests 21:40:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:40:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:40:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:40:59 INFO - 2016-08-17 21:40:59.966 screenresolution[2235:17305] starting screenresolution argv=screenresolution get 21:40:59 INFO - 2016-08-17 21:40:59.968 screenresolution[2235:17305] Display 0: 1600x1200x32@60 21:40:59 INFO - 2016-08-17 21:40:59.974 screenresolution[2236:17308] starting screenresolution argv=screenresolution list 21:40:59 INFO - Available Modes on Display 0 21:40:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:40:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:40:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:40:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:41:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:41:00 INFO - Intel Iris: 21:41:00 INFO - Chipset Model: Intel Iris 21:41:00 INFO - Type: GPU 21:41:00 INFO - Bus: Built-In 21:41:00 INFO - VRAM (Dynamic, Max): 1536 MB 21:41:00 INFO - Vendor: Intel (0x8086) 21:41:00 INFO - Device ID: 0x0a2e 21:41:00 INFO - Revision ID: 0x0009 21:41:00 INFO - Displays: 21:41:00 INFO - Display: 21:41:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:41:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:41:00 INFO - Display Serial Number: 1600x1200 60 21:41:00 INFO - Main Display: Yes 21:41:00 INFO - Mirror: Off 21:41:00 INFO - Online: Yes 21:41:00 INFO - Rotation: Supported 21:41:00 INFO - Return code: 0 21:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:41:00 INFO - Python 2.7.3 21:41:00 INFO - Return code: 0 21:41:00 INFO - grabbing minidump binary from tooltool 21:41:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:41:00 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 0x103a53d30>, '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 0x1037b8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103a4bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:41:00 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 21:41:00 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 21:41:00 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 21:41:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:00 INFO - Return code: 0 21:41:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:41:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:41:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:00 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-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:41:00 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-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:41:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.thzEs3QGa3/Render', 21:41:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:41:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:41:00 INFO - 'HOME': '/Users/cltbld', 21:41:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:41:00 INFO - 'LOGNAME': 'cltbld', 21:41:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:00 INFO - 'MOZ_NO_REMOTE': '1', 21:41:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:00 INFO - 'NO_EM_RESTART': '1', 21:41:00 INFO - 'PAGER': '/bin/cat', 21:41:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:00 INFO - 'PWD': '/builds/slave/test', 21:41:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:41:00 INFO - 'SHELL': '/bin/bash', 21:41:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.acV8jGuAxV/Listeners', 21:41:00 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 21:41:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:41:00 INFO - 'USER': 'cltbld', 21:41:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:41:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:00 INFO - 'XPC_FLAGS': '0x0', 21:41:00 INFO - 'XPC_SERVICE_NAME': '0', 21:41:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:41:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:41:00 INFO - mozversion application_buildid: 20160817174714 21:41:00 INFO - mozversion application_changeset: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce 21:41:00 INFO - mozversion application_display_name: Nightly 21:41:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:00 INFO - mozversion application_name: Firefox 21:41:00 INFO - mozversion application_remotingname: firefox 21:41:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:41:00 INFO - mozversion application_vendor: Mozilla 21:41:00 INFO - mozversion application_version: 51.0a1 21:41:00 INFO - mozversion platform_buildid: 20160817174714 21:41:00 INFO - mozversion platform_changeset: 3ebc785598eee4e31ff83b7cb859cb5b9c9147ce 21:41:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:41:00 INFO - mozversion platform_version: 51.0a1 21:41:00 INFO - using testdate: 1471495260 21:41:00 INFO - actual date: 1471495260 21:41:00 INFO - starting webserver on 'localhost:52225' 21:41:00 INFO - SUITE-START | Running 2 tests 21:41:00 INFO - TEST-START | dromaeo_css 21:41:00 INFO - operating with platform_type : mac_ 21:41:00 INFO - Initialising browser for dromaeo_css test... 21:41:00 INFO - TEST-INFO | started process 2246 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpLAwN37/profile http://localhost:52225/getInfo.html) 21:41:03 INFO - PROCESS | 2246 | __metrics Screen width/height:1600/1200 21:41:03 INFO - PROCESS | 2246 | colorDepth:24 21:41:03 INFO - PROCESS | 2246 | Browser inner width/height: 1024/689 21:41:03 INFO - PROCESS | 2246 | __metrics 21:41:03 ERROR - PROCESS | 2246 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:41:03 INFO - TEST-INFO | 2246: exit 0 21:41:03 INFO - Browser initialized. 21:41:03 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:03 INFO - TEST-INFO | started process 2249 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpLAwN37/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:16 INFO - PROCESS | 2249 | RSS: Main: 238989312 21:41:16 INFO - PROCESS | 2249 | 21:42:05 INFO - PROCESS | 2249 | 1471495325665 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] 21:44:17 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:52225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52225/tests/dromaeo/cssquery-ext.html) 21:44:18 INFO - PROCESS | 2249 | RSS: Main: 253980672 21:44:18 INFO - PROCESS | 2249 | 21:47:21 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:52225/tests/dromaeo/cssquery-ext.html (next: http://localhost:52225/tests/dromaeo/cssquery-jquery.html) 21:47:22 INFO - PROCESS | 2249 | RSS: Main: 265998336 21:47:22 INFO - PROCESS | 2249 | 21:50:23 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:52225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52225/tests/dromaeo/cssquery-mootools.html) 21:50:24 INFO - PROCESS | 2249 | RSS: Main: 270921728 21:50:24 INFO - PROCESS | 2249 | 21:53:26 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:52225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52225/tests/dromaeo/cssquery-prototype.html) 21:53:27 INFO - PROCESS | 2249 | RSS: Main: 270381056 21:53:27 INFO - PROCESS | 2249 | 21:56:29 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:52225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52225/tests/dromaeo/cssquery-yui.html) 21:56:30 INFO - PROCESS | 2249 | RSS: Main: 275755008 21:56:30 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | Cycle 1(1): loaded http://localhost:52225/tests/dromaeo/cssquery-yui.html (next: http://localhost:52225/tests/dromaeo/cssquery-dojo.html) 21:59:33 INFO - PROCESS | 2249 | RSS: Main: 279199744 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | __start_tp_report 21:59:33 INFO - PROCESS | 2249 | _x_x_mozilla_page_load 21:59:33 INFO - PROCESS | 2249 | _x_x_mozilla_page_load_details 21:59:33 INFO - PROCESS | 2249 | |i|pagename|runs| 21:59:33 INFO - PROCESS | 2249 | |0;dojo.html;2828.2646511906905;2977.80887644942;3372.56156699629;3400.4389275769486;3423.5378223939774;4724.952750472494;5701.515371193444;5817.73820178092;5907.40925907409;5919.37846526115;5788.450097240766;5836.387179346171;5861.443162899528;5861.8827623447505;5936.079907614327;5207.843764687056;5310.522053015228;5335.013022590813;5373.140297552392;5399.082156033483;5375.731213439332;5386.73066346683;5413.729313534327;5414.214938833887;5453.2092846537225;5173.224016397552;5220.556252718524;5277.366715994067;5296.92054619181;5317.73411329432;5256.395514515842;5267.26258323835;5268.81559145428;5361.356637203521;5363.436839131874;4202.390653355277;5293.920591191135;5308.575313974911;5329;5339.492748188916;4524.366588677588;5659.037963546207;5827.446392592697;5848.122781582754;5867.911981320283;6187.690615469209;6234.906476402857;6243.250809902841;6281.24625044993;6287.245530536365;6164.260288765332;6189.38106189382;6263.4362907338555;6276.937230627681;6320.494360451153;5939.524838012949;6003.939960600425;6030.306514750772;6068.393160683941;6078.1186727924205;6333.904991425133;6354.237491500957;6371.617702937746;6374.235091789015;6379.808605741835;5747.6838773867;6082.695865206722;6135.814547850547;6245.531585131133;6256.937430625636;6172.475339596095;6198.938010619926;6231.158793562901;6300.495960323163;6330.746770129143;5101.8724531886255;5220.399654039758;6193.659348735863;6201.10084037812;6295.6537390443045;6207.751689932352;6237.937620623827;6305.936940630535;6311.873762524724;6337.049442583557;4982.800687972513;5019.598432125421;5023.648344615842;5046.571041461443;5065.6200784941275;4423;4489.079738653568;4509.594136527729;4516.728996260234;4527.411436513232;5241.868953276198;5586.86032849182;5877.294724633071;5966.105084237399;6019.608725432833;6196.225471816023;6214.689265536705;6249.187605611332;6268.686565671698;6285.277193122758;4836.613070954315;5958.255218097738;5970.402959704082;5981.764735190058;6008.158857759917;5541.085720856014;5555.416681248411;5557.916631250535;5565.276514053228;5569.331680198402;6107.541934354852;6206.844828879314;6284.874302514016;6296.464800491918;6326.873462530815;6296.307406185224;6299.370062993664;6317.905231421624;6326.493880489642;6336.20797400325;6344.524160687874;6375.6174629522375;6386.233651961795;6395.712192951235;6396.296407395276;6102.246889800232;6184.474319682698;6190.380961903774;6247.437730604267;6311.558190926775;6282.528810339334;6302.054691796267;6312.4634406076;6313.55805093639;6325.715342809676;5367.060764366299;6246.3753624637175;6258.499320054294;6263.467605253604;6272.278687950944;6072.514198864169;6161.199044124235;6179.598326108789;6180.165677633642;6265.4361107500545;4727.841678788719;5025.422076461254;5292.391374991771;6068.120122582289;6161.537884658758;6180.81457556274;6225.595336303126;6239.188905442264;6274.560780745486;6280.905786413299;5992.730327135202;6089.69551522431;6107.877842443215;6122.693865306628;6165.630062196283 21:59:33 INFO - PROCESS | 2249 | |1;ext.html;457.19533620827343;527;527.6412039812927;540.8458589302049;554.5037191713415;38250.426243606336;40642.59357406425;40651.39022914655;40731.38902916459;40739;41691.37462938058;42228.57771422285;42238;42335.364969525406;42398.36402453966;9692.56383462744;9910.603575856992;9912.157466615346;9917.256205784559;9926.354786938862;8724.52015139167;9413.435193888354;9800;9845.803083938317;9896.109350158484;9837.90162098377;9850.261230407712;9873.40759554429;9875.160611348045;9892.258080643944;9822.410655360665;9825.754356141118;9865.309428340019;9874.456904870229;9900.603975840957;9729.756756081084;9835.90164098357;9841.852372214422;9862.408255504693;9880.258980576486;39798.0050498737;40026.79986600077;40151.59848401508;40194.39708404347;40207.396889046686;3354.312365964996;3920.529536455615;4154.273002224599;4178.143480586473;4180.101278225196;28165.85917070422;29723.959661411962;30230.84884575585;30415.847920760254;30480.085597432113;2638.854862982535;2726.2366537369567;3227.4190645683766;3389.5254664347012;3439.3465241604017;495414;504035;504273;505105;506335.468322656;60305;60318.095228571605;60651.11535500357;60700.69649651724;60715.39284607186;58172.70913645405;58720.41279587235;58883;59165.112523312186;59333.11000334998;16241.918790405973;16390.918045409697;16466.341346346013;16542.007479551266;16543.338266469207;12596.929261012734;12764;12825.679358016125;12826.9358653208;12836;12829.679258018437;15565.754739620803;15849.286782094834;16256.59358516023;16425.01449913009;6039.275286965592;7099.822504437327;7188.784336469915;7230.530015548972;7287.70849166038;804.830985493053;915.1062230210545;932.8181004704153;953.1374106433689;1038.3510306058713;28883.71116288852;29548.852255739013;30406.695933040828;30650.693493064784;31131.68868311333;894.9776255593532;1031.9071283584512;1055.9524821383056;1128.4245035032193;1156.8258217908829;15598.766018509732;17173.398931037354;17229;17429.389971351196;17430;612714;646384;649755.7512212408;653642;653846;59712;60625.69687151536;60818.391816082156;60841.69579152076;60927;1163.2729544035146;1311.0036372356888;1381.1229869033236;1393.3451277899371;1402.2848347342929;27000.729992700606;29671.703282966893;30930.987956623318;31625.73497060092;32435.35129297448;51499.48500515097;52052.47947520476;52170;52253;52279.73860130675;544497.9951804198;554093;554459;554503;555397;25988.220353389428;26062.86968565145;26457.60313595259;26476.94092236289;26558.336041599116;47623.52376476191;47717.52282477131;48730.512694872596;48764.2685359727;48959.166533354495;39399.80300098481;39569.208615828094;39677.603223968545;40112.59887401089;41103.58896410998;39233.41149882697;39724.404133938595;40406.989825253426;40602.593974059884;40825.775226743244;32937.83531082329;37721;38467.2306553873;39032.804835975636;40253;32546.51180232251;33668.83165584156;34094;34499.65500344965;35363.292734144656;21684.79564904443;22189.55620887541;23987.880060599586;25255.621165682896;25601.871990639927 21:59:33 INFO - PROCESS | 2249 | |2;jquery.html;368.7363535072424;369.6488336080723;370.6108585984716;385.5604610743751;394.4773175542405;17531.47405577833;20589.970501474923;21452.678209826827;22292.442688932766;22471.66292505614;20999.580008399862;21131.260405885798;21152.57694846106;21188.8940555297;21503;5874.794382196624;5964.3439221685685;6119.479844213225;6177.752889884399;6206.906896396557;3693.722970777189;6096.847578810521;6193;6202.565820392574;6590.406863382294;6782.287859774727;6948.583085014915;6954.930450695504;6959.860802783941;6970.860582788341;6742.460603151761;6882.754296122656;6942.548734332252;6946.652667366637;6950.165980082372;5945.316288626776;5965.105234214859;5996.190514280604;6012.3085845127935;6035.185249991283;26881.865590672118;26987.73012269872;27010.324741881414;27019.729802701917;27060.45879082427;2241.2939923923914;2707.986460067687;3039.316153865385;3152.917495005059;3246.3345014272254;13121.606351809365;15143.848561514355;15993.600159995976;16322.591935201595;16733.74899376498;1847.4642353717406;1880.7178923161498;1882.2471011595335;1898.3545594497937;1914.1290712725815;100474.49762751213;108510.45744771305;109992;110263;110324;10498.737531561772;10617.575296988189;10658.467076646137;11003.61487347939;11186.496607652674;10240.078392944672;12205.38973051344;13638.590842274747;13639.249841258827;13675.24786136772;6680.899786503206;7012.333828286304;7148.35664790161;8554.828903421896;8618.956905215558;8659.740207793777;8712.825743485095;8754.86867696985;8875.28997680184;8882.378233523592;5500.80747173847;6618.503612229102;6743.291954344723;6843.555168914005;6867.759628412981;1561.960950976212;1641.3352592200179;1804.7292906063933;1865.6455273498264;1890.366727146394;759.8746206875803;868.3574155125289;873.1835733589114;919.6183583812776;992.4591097851688;16227.918860405622;21037.368878933656;21631;21917.671234931488;22136.557268854533;890.5235698901057;920.5259291464768;925.4956048953337;1031.504877658713;1049.7847941172042;10914.181436392302;11186.272892261977;11379.658610241706;11564.959153676042;11568.88431115678;455023;566220;583239;598878.0168297479;610446;131838.38565650157;134550;134718.32640836734;136519.95220071706;137993;950.3157726436955;965.7633879699378;985.8816941966867;987.2299606307092;988.17981075707;18458.98475583856;18901.243950241835;19021.809781902004;19064.809351906304;19095.52261193481;41785;43100;46433.76783116063;52072.69818254574;55422.44577554173;50729.47811565659;69276.61446771138;76116.61941690255;77555;78838;6586.868262634816;6604.877170880865;7314.634268286671;7420.220876807857;7441.144268409203;11401.714957125807;12277;12662;12877.806832897326;13133.802992955305;8141.755747327589;10630.8936910633;11017.504212310305;11146.665600032013;11492.54029838797;9281.907180928105;10357.13571557127;10791.730206744895;11151.776964460827;11534.826977595176;10405.895941040795;10583.153347732008;11346.978771910568;11739.823902641638;11863;7920.881186782088;7945.284924356835;8171.79570510742;8282.461639993382;8298.08721040673;9029;10090.2432317575;11334.659960201207;11335.603253886075;11574.421278935852 21:59:33 INFO - PROCESS | 2249 | |3;mootools.html;1361.8774310312072;1507.8341382447932;1699.286299754103;1826.8629852761046;1852.2498388152803;7883.605819709021;8383.245507904287;8563.10087440819;8953.686620968267;8981.865272020917;8597;8809.911900880988;8814.030456649763;8816.647334106645;8820;2316.814654827614;2357.6227803551437;2367.1596583212886;2372.489914668346;2374.536965291769;2342.9882850585723;2345.319857241398;2379.9881000594974;2380.642903564462;2391.222852572912;2343.7773411525964;2352.4001379648166;2359.445530300378;2366.881655917206;2372.003758421467;2318.594246006942;2333.88330583471;2348.53029394121;2354.9058037678474;2358.599038163508;2226.421130506064;2335.2410466598253;2340.461693810416;2346.5424242272766;2369.6563998220163;8838.955805220998;8899.599518021705;8920.8661870072;8921.375503714742;8925.241354484877;4157.9605098725315;4287.421198138242;4963.957568910533;5076.593872490192;5127.461616530285;3509.7543171977973;3531.5055892175114;3668.3580373434543;3685.4656074869263;3690.225052738928;1058.841173823925;1077.2297807067985;1098.0995583621354;1122.1079242002545;1123.7752449510049;11520.423978801027;11571.942140289244;11607.941960290145;11671.358075305854;11710.765784684343;4530.116627257719;4631;4809.95190048102;4845.248986407112;4853.223484242504;9816;9934.155596774355;9961.203103751683;9973.750656233653;9975.102240798218;4982.352294201731;5122.847359344192;5345.625806193529;5345.786168553292;5366.7853285868905;3659.597444281127;4756.191447453941;4888.315635810989;4906.1414252505665;4911.386076740408;3845.615438456188;3917.7845218513257;3979.621935916083;3991.860284890015;4019.33680942647;1283.9807402888964;1297.1633296523878;1305.5756879014168;1311.4819646239873;1312.4946895445323;826.7643721539332;898.3397203055749;909.4406939732017;922.9446233226028;949.3259785552335;5413.133898576209;5632.239647647597;5903.0260007099205;6000.969995149996;6044.607100538539;909.554318383987;922.6032805893396;927.3601215161652;962.9181519570775;969.9466529340813;4006.979965100214;4008.1983603278877;4059.06641472463;4148.357004664282;4149.709520333608;10354.741131471774;10861.402622855661;10874.130069594414;10907.400092994803;10956.890431095746;10834.079103276152;10835.128690896918;10839.807621161666;10854.511546980404;10908.836367454494;8187.95906020478;8306.750797476085;8307.750767476986;8319.376046796393;8329.958755155605;5483.890322193613;5602.3837377887585;6032.185654936703;6081.209442772411;6091.634501929899;9122.954385228031;9725.854112188465;10023.797144342725;10095.697129086138;10140.54367553447;10118.544665490217;10322.071013608811;10331.94834025825;10362.689119326433;10398.428086455318;6949.096617439701;7432.405407567274;7488.101427828696;7532.5857077859055;7717.459777815499;8503.872441913252;8559.486430813922;8581;8611.052784193858;8619.612117454855;7373.967644529663;7445.218252083453;7552;7610.543367397974;7684.807879803049;7333.853322933404;7458.664360103917;7493.175750667531;7589.43079269046;7639.236076392316;5743.62666426681;6657.367550082734;6783;6810.28492008332;6822.931770682229;4893.853184404331;4956.008798240294;4986.351774269322;5099.2860999460845;5149.871253218699;4960.727160006234;4991.401031876198;5115.616328775282;5140.30605868203;5178.964207158659 21:59:33 INFO - PROCESS | 2249 | |4;prototype.html;263.27467826138985;266.41920613063536;308.4524968181478;310.20277885833417;315.35667238832775;4466.3523789050605;4900.705957642544;5269.420363759983;5485.478879506445;5576.749046292922;5223.14578324695;5408.378036525791;5506.449355064502;5556.888862222753;5583.3300003999575;4078.4697989261354;4180.895477613054;4205.11692544566;4213.810378532958;4217.683673724468;3327.7005069543734;3527.294541091779;4068.125353049094;4191.2874811282;4215.515215750182;3372.8700885203484;4071.084006098634;4076.9184616307657;4094.6724262058965;4094.89762755932;4095.385692146202;4095.8361665533344;4118.8970275743195;4134.586541345871;4144.48193975753;3548.6628770267043;3568.7323450741037;3573.1781690211137;3576.517170182044;3598.298331825269;4093.385992101179;4949.663590830492;5225.909636145534;5289.920651190235;5361.463853614608;4767.022760334124;4777.211760059586;4798.47216806151;4809.416984346649;4810.422749270075;5058.898822023576;5474.863128421821;5759.041925745225;5812.052962257649;5865.149553314788;3210.678932106794;3854.2291541691775;3961.1483531040676;4026;4037.737547059461;4958.528939750718;6002.96998515009;6018.578699491038;6023.728932198018;6070.6021121656695;4075.8369665213654;4122.525909520384;4130.380442933584;4131.607497287753;4141.81361838718;3965.7111438781935;4148.668106551469;4179.2477354076555;4194.307939189999;4202.663786897041;4766.666333356632;4786.880327991758;4823.710577365369;4827.3345695734915;4844.660873738804;4591.347115038583;5034.684045339185;5731.627444216196;5771.913421298684;5877.0596704527925;1212.6422705301957;1252.949882004728;1392.7632302508598;1399.3213291553589;1419.737348590514;941.0899550820856;949.5252373813094;972.644984580623;972.8451479971897;974.9512524373753;4942;4963.677360971526;5160.974195129001;5322.509697284767;5489.725513724298;4326.2212801696;4766.971908737111;5497.092979658311;5939.713210414022;5983.640981541122;4738.857834264978;4802.663813533089;5058.013687330935;5074.594032477393;5337.679739215582;2156.202205184092;2403.651470536762;2481.33004088895;2541;2543.0717788007246;4589.862304130881;4862.881537246453;5094.18493041119;5100.7959681613065;5130.615203859726;4453.374518300861;4686.390769199982;5033.421156566968;5038.5969122470115;5063.645544811901;5342.519173274346;5848.912266316009;6217.911865423533;6239.594426362272;6247.781327653511;4981.480648402127;5240.873212259383;5251.26482292487;6047.455728984412;6104.908426373519;5709.34342550612;5866.7066646668345;5884.705764711833;5930.584859059824;6010.158577799024;6187.783427580193;6187.907181392193;6194.194754681863;6212.720427580679;6221.502279817513;3727.7017838572306;3966.3852102924093;3979.900502487461;3986.3023970805575;4016.3090729210912;4921.8523444296725;5640.492355688008;5931.258592675916;5966.210136958982;5992.790252341147;4924.4090709115135;5202.60980426462;5897.557683173865;5917.201177840936;5945.31628862669;5832.679202643895;5839.211706419579;5860.531157507475;5869.207656966255;5943.29580041089;5355.4376790436445;5575.076598573486;5658.632188907708;5785;5814.215080964185;4837.7581120943105;4846.345743324606;5042.546170844642;5345.305110335631;5945.40545945402;5105.825660098272;5738.426157384395;5788.044972579645;5807.941920580909;5815.331236907809 21:59:33 INFO - PROCESS | 2249 | |5;yui.html;637.3148864970156;718.9784306470806;740.6704016712565;775.8564665536876;853.5433543054467;15617.765733514007;15937.92031039846;16315.510534683963;16381.508554743346;16408.26162822673;14285.428582856674;14897.404103835861;15032.398704051824;15046.54860354191;15059.472918447857;678.4301187002917;860.5912191708935;884.0319849764497;890.0254221627308;893.3121496447732;854.7093988044064;882.2500874256863;887.2591386192505;888.3559419420933;891.888513935758;904.5612877754284;928.1878356438117;928.3223247029672;928.3733479901074;932.664240873285;893.4907102951321;894.5080205886801;921.037515795988;923.0953665407905;923.5013092929844;688.3667026335783;689.3898899473952;689.9103116594811;693.0816667914983;694.0456871801273;11453.65639030822;14328.856711432856;14882.181480018595;15181.772273415907;15219.239038048054;12802.911752501048;13695.726085478334;14662.120272783666;14675.119492830465;14948;9753.927068022513;10875.619353322596;11629.185956983014;11869.5845645402;11967.341796201206;3732.496113024734;3877.476540667002;3925;3931.6461518463475;3974.125692347679;94438.0556194436;99708.00875973732;109823.45088274588;111982;113923.86076139132;10682.412467314218;10787.78424431507;10980.341179529254;11311.717207069889;11347.829782553268;20566;20815.479613009495;20880.686789698168;20905.686414703792;20963.790362096184;7907.683692652345;7939.325157361689;7944.404169687296;8056.194380561897;8207.138250483733;4539.682222244412;4611.308303754464;4635.814567417333;4660.347551342815;4750.287456881495;3495.8252087395526;3630.0561853917643;3630.5098811660087;3637.5998640149564;3642.235130622546;549.2667289169004;640.8846407646669;644.0275184471482;665.816900352407;668.9498287628447;558.48340285236;659.0970370592319;665.8568407792251;667.813012356541;694.1739330197049;8734.213920747035;9626.759331016641;9715.805683886283;9782.853257201148;9783.804323913624;613.2793967088653;623.382850977529;660.9325938609112;671.9462443004547;676.6028151866478;4418.8453404130705;4685.531446855287;4689.132510485503;4694.906101877943;4704.200320695812;88610.55694721485;122709.38645306895;154645;159301;160045;137587.93618095736;139211;139606;140459;141945;118735;120023;120361.39819300847;122787.77212227942;123803.38098309451;9109.316801240066;9172.495512746596;9244.907550924674;9261.76845578839;9518.95240523793;47775.04449911052;53904.65238369072;55000;55340;58260;63940;72083.63958180175;75317.87023194766;80184;93722;13148.698977678676;13330.200187988752;13449.260290684106;13700.588982330546;14005.949553783303;14692.265386730835;14723.92638036803;14830.62923426923;14977.625559361104;15704.685906282039;13648.691013500353;13818.239996800272;14239.71520569562;14406.567802965928;14453.927730361702;13719.862801372257;13867.722645547234;13954.023218374616;13977;14371.425142994163;13356.198628082346;13455;13713.108647937852;13732.725345492834;13995.300234988006;11216.719582010515;11402.315861048364;11425.828612570653;11448.542058317908;11622.88377116218;10754.677359679223;10900.727481813017;11384.32291744429;11582.71043223926;11598.47806848677 21:59:33 INFO - PROCESS | 2249 | __end_tp_report 21:59:33 INFO - PROCESS | 2249 | __start_cc_report 21:59:33 INFO - PROCESS | 2249 | _x_x_mozilla_cycle_collect,405 21:59:33 INFO - PROCESS | 2249 | __end_cc_report 21:59:33 INFO - PROCESS | 2249 | __startTimestamp1471496373907__endTimestamp 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | ------- Summary: start ------- 21:59:33 INFO - PROCESS | 2249 | Number of tests: 6 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | [#0] dojo.html Cycles:165 Average:5764.09 Median:6068.39 stddev:693.05 (11.4%) stddev-sans-first:655.79 21:59:33 INFO - PROCESS | 2249 | Values: 2828.3 2977.8 3372.6 3400.4 3423.5 4725.0 5701.5 5817.7 5907.4 5919.4 5788.5 5836.4 5861.4 5861.9 5936.1 5207.8 5310.5 5335.0 5373.1 5399.1 5375.7 5386.7 5413.7 5414.2 5453.2 5173.2 5220.6 5277.4 5296.9 5317.7 5256.4 5267.3 5268.8 5361.4 5363.4 4202.4 5293.9 5308.6 5329.0 5339.5 4524.4 5659.0 5827.4 5848.1 5867.9 6187.7 6234.9 6243.3 6281.2 6287.2 6164.3 6189.4 6263.4 6276.9 6320.5 5939.5 6003.9 6030.3 6068.4 6078.1 6333.9 6354.2 6371.6 6374.2 6379.8 5747.7 6082.7 6135.8 6245.5 6256.9 6172.5 6198.9 6231.2 6300.5 6330.7 5101.9 5220.4 6193.7 6201.1 6295.7 6207.8 6237.9 6305.9 6311.9 6337.0 4982.8 5019.6 5023.6 5046.6 5065.6 4423.0 4489.1 4509.6 4516.7 4527.4 5241.9 5586.9 5877.3 5966.1 6019.6 6196.2 6214.7 6249.2 6268.7 6285.3 4836.6 5958.3 5970.4 5981.8 6008.2 5541.1 5555.4 5557.9 5565.3 5569.3 6107.5 6206.8 6284.9 6296.5 6326.9 6296.3 6299.4 6317.9 6326.5 6336.2 6344.5 6375.6 6386.2 6395.7 6396.3 6102.2 6184.5 6190.4 6247.4 6311.6 6282.5 6302.1 6312.5 6313.6 6325.7 5367.1 6246.4 6258.5 6263.5 6272.3 6072.5 6161.2 6179.6 6180.2 6265.4 4727.8 5025.4 5292.4 6068.1 6161.5 6180.8 6225.6 6239.2 6274.6 6280.9 5992.7 6089.7 6107.9 6122.7 6165.6 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | [#1] ext.html Cycles:180 Average:70062.99 Median:40964.68 stddev:152070.55 (371.2%) stddev-sans-first:152407.35 21:59:33 INFO - PROCESS | 2249 | Values: 457.2 527.0 527.6 540.8 554.5 38250.4 40642.6 40651.4 40731.4 40739.0 41691.4 42228.6 42238.0 42335.4 42398.4 9692.6 9910.6 9912.2 9917.3 9926.4 8724.5 9413.4 9800.0 9845.8 9896.1 9837.9 9850.3 9873.4 9875.2 9892.3 9822.4 9825.8 9865.3 9874.5 9900.6 9729.8 9835.9 9841.9 9862.4 9880.3 39798.0 40026.8 40151.6 40194.4 40207.4 3354.3 3920.5 4154.3 4178.1 4180.1 28165.9 29724.0 30230.8 30415.8 30480.1 2638.9 2726.2 3227.4 3389.5 3439.3 495414.0 504035.0 504273.0 505105.0 506335.5 60305.0 60318.1 60651.1 60700.7 60715.4 58172.7 58720.4 58883.0 59165.1 59333.1 16241.9 16390.9 16466.3 16542.0 16543.3 12596.9 12764.0 12825.7 12826.9 12836.0 12829.7 15565.8 15849.3 16256.6 16425.0 6039.3 7099.8 7188.8 7230.5 7287.7 804.8 915.1 932.8 953.1 1038.4 28883.7 29548.9 30406.7 30650.7 31131.7 895.0 1031.9 1056.0 1128.4 1156.8 15598.8 17173.4 17229.0 17429.4 17430.0 612714.0 646384.0 649755.8 653642.0 653846.0 59712.0 60625.7 60818.4 60841.7 60927.0 1163.3 1311.0 1381.1 1393.3 1402.3 27000.7 29671.7 30931.0 31625.7 32435.4 51499.5 52052.5 52170.0 52253.0 52279.7 544498.0 554093.0 554459.0 554503.0 555397.0 25988.2 26062.9 26457.6 26476.9 26558.3 47623.5 47717.5 48730.5 48764.3 48959.2 39399.8 39569.2 39677.6 40112.6 41103.6 39233.4 39724.4 40407.0 40602.6 40825.8 32937.8 37721.0 38467.2 39032.8 40253.0 32546.5 33668.8 34094.0 34499.7 35363.3 21684.8 22189.6 23987.9 25255.6 25601.9 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | [#2] jquery.html Cycles:180 Average:33826.49 Median:2873.65 stddev:94562.84 (3290.7%) stddev-sans-first:94794.75 21:59:33 INFO - PROCESS | 2249 | Values: 368.7 369.6 370.6 385.6 394.5 17531.5 20590.0 21452.7 22292.4 22471.7 20999.6 21131.3 21152.6 21188.9 21503.0 5874.8 5964.3 6119.5 6177.8 6206.9 3693.7 6096.8 6193.0 6202.6 6590.4 6782.3 6948.6 6954.9 6959.9 6970.9 6742.5 6882.8 6942.5 6946.7 6950.2 5945.3 5965.1 5996.2 6012.3 6035.2 26881.9 26987.7 27010.3 27019.7 27060.5 2241.3 2708.0 3039.3 3152.9 3246.3 13121.6 15143.8 15993.6 16322.6 16733.7 1847.5 1880.7 1882.2 1898.4 1914.1 100474.5 108510.5 109992.0 110263.0 110324.0 10498.7 10617.6 10658.5 11003.6 11186.5 10240.1 12205.4 13638.6 13639.2 13675.2 6680.9 7012.3 7148.4 8554.8 8619.0 8659.7 8712.8 8754.9 8875.3 8882.4 5500.8 6618.5 6743.3 6843.6 6867.8 1562.0 1641.3 1804.7 1865.6 1890.4 759.9 868.4 873.2 919.6 992.5 16227.9 21037.4 21631.0 21917.7 22136.6 890.5 920.5 925.5 1031.5 1049.8 10914.2 11186.3 11379.7 11565.0 11568.9 455023.0 566220.0 583239.0 598878.0 610446.0 131838.4 134550.0 134718.3 136520.0 137993.0 950.3 965.8 985.9 987.2 988.2 18459.0 18901.2 19021.8 19064.8 19095.5 41785.0 43100.0 46433.8 52072.7 55422.4 50729.5 69276.6 76116.6 77555.0 78838.0 6586.9 6604.9 7314.6 7420.2 7441.1 11401.7 12277.0 12662.0 12877.8 13133.8 8141.8 10630.9 11017.5 11146.7 11492.5 9281.9 10357.1 10791.7 11151.8 11534.8 10405.9 10583.2 11347.0 11739.8 11863.0 7920.9 7945.3 8171.8 8282.5 8298.1 9029.0 10090.2 11334.7 11335.6 11574.4 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | [#3] mootools.html Cycles:180 Average:5716.21 Median:4933.70 stddev:3219.03 (65.2%) stddev-sans-first:3211.42 21:59:33 INFO - PROCESS | 2249 | Values: 1361.9 1507.8 1699.3 1826.9 1852.2 7883.6 8383.2 8563.1 8953.7 8981.9 8597.0 8809.9 8814.0 8816.6 8820.0 2316.8 2357.6 2367.2 2372.5 2374.5 2343.0 2345.3 2380.0 2380.6 2391.2 2343.8 2352.4 2359.4 2366.9 2372.0 2318.6 2333.9 2348.5 2354.9 2358.6 2226.4 2335.2 2340.5 2346.5 2369.7 8839.0 8899.6 8920.9 8921.4 8925.2 4158.0 4287.4 4964.0 5076.6 5127.5 3509.8 3531.5 3668.4 3685.5 3690.2 1058.8 1077.2 1098.1 1122.1 1123.8 11520.4 11571.9 11607.9 11671.4 11710.8 4530.1 4631.0 4810.0 4845.2 4853.2 9816.0 9934.2 9961.2 9973.8 9975.1 4982.4 5122.8 5345.6 5345.8 5366.8 3659.6 4756.2 4888.3 4906.1 4911.4 3845.6 3917.8 3979.6 3991.9 4019.3 1284.0 1297.2 1305.6 1311.5 1312.5 826.8 898.3 909.4 922.9 949.3 5413.1 5632.2 5903.0 6001.0 6044.6 909.6 922.6 927.4 962.9 969.9 4007.0 4008.2 4059.1 4148.4 4149.7 10354.7 10861.4 10874.1 10907.4 10956.9 10834.1 10835.1 10839.8 10854.5 10908.8 8188.0 8306.8 8307.8 8319.4 8330.0 5483.9 5602.4 6032.2 6081.2 6091.6 9123.0 9725.9 10023.8 10095.7 10140.5 10118.5 10322.1 10331.9 10362.7 10398.4 6949.1 7432.4 7488.1 7532.6 7717.5 8503.9 8559.5 8581.0 8611.1 8619.6 7374.0 7445.2 7552.0 7610.5 7684.8 7333.9 7458.7 7493.2 7589.4 7639.2 5743.6 6657.4 6783.0 6810.3 6822.9 4893.9 4956.0 4986.4 5099.3 5149.9 4960.7 4991.4 5115.6 5140.3 5179.0 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | [#4] prototype.html Cycles:180 Average:4589.00 Median:5007.45 stddev:1425.86 (28.5%) stddev-sans-first:1392.40 21:59:33 INFO - PROCESS | 2249 | Values: 263.3 266.4 308.5 310.2 315.4 4466.4 4900.7 5269.4 5485.5 5576.7 5223.1 5408.4 5506.4 5556.9 5583.3 4078.5 4180.9 4205.1 4213.8 4217.7 3327.7 3527.3 4068.1 4191.3 4215.5 3372.9 4071.1 4076.9 4094.7 4094.9 4095.4 4095.8 4118.9 4134.6 4144.5 3548.7 3568.7 3573.2 3576.5 3598.3 4093.4 4949.7 5225.9 5289.9 5361.5 4767.0 4777.2 4798.5 4809.4 4810.4 5058.9 5474.9 5759.0 5812.1 5865.1 3210.7 3854.2 3961.1 4026.0 4037.7 4958.5 6003.0 6018.6 6023.7 6070.6 4075.8 4122.5 4130.4 4131.6 4141.8 3965.7 4148.7 4179.2 4194.3 4202.7 4766.7 4786.9 4823.7 4827.3 4844.7 4591.3 5034.7 5731.6 5771.9 5877.1 1212.6 1252.9 1392.8 1399.3 1419.7 941.1 949.5 972.6 972.8 975.0 4942.0 4963.7 5161.0 5322.5 5489.7 4326.2 4767.0 5497.1 5939.7 5983.6 4738.9 4802.7 5058.0 5074.6 5337.7 2156.2 2403.7 2481.3 2541.0 2543.1 4589.9 4862.9 5094.2 5100.8 5130.6 4453.4 4686.4 5033.4 5038.6 5063.6 5342.5 5848.9 6217.9 6239.6 6247.8 4981.5 5240.9 5251.3 6047.5 6104.9 5709.3 5866.7 5884.7 5930.6 6010.2 6187.8 6187.9 6194.2 6212.7 6221.5 3727.7 3966.4 3979.9 3986.3 4016.3 4921.9 5640.5 5931.3 5966.2 5992.8 4924.4 5202.6 5897.6 5917.2 5945.3 5832.7 5839.2 5860.5 5869.2 5943.3 5355.4 5575.1 5658.6 5785.0 5814.2 4837.8 4846.3 5042.5 5345.3 5945.4 5105.8 5738.4 5788.0 5807.9 5815.3 21:59:33 INFO - PROCESS | 2249 | 21:59:33 INFO - PROCESS | 2249 | [#5] yui.html Cycles:180 Average:24469.53 Median:3687.37 stddev:39412.63 (1068.9%) stddev-sans-first:39482.57 21:59:33 INFO - PROCESS | 2249 | Values: 637.3 719.0 740.7 775.9 853.5 15617.8 15937.9 16315.5 16381.5 16408.3 14285.4 14897.4 15032.4 15046.5 15059.5 678.4 860.6 884.0 890.0 893.3 854.7 882.3 887.3 888.4 891.9 904.6 928.2 928.3 928.4 932.7 893.5 894.5 921.0 923.1 923.5 688.4 689.4 689.9 693.1 694.0 11453.7 14328.9 14882.2 15181.8 15219.2 12802.9 13695.7 14662.1 14675.1 14948.0 9753.9 10875.6 11629.2 11869.6 11967.3 3732.5 3877.5 3925.0 3931.6 3974.1 94438.1 99708.0 109823.5 111982.0 113923.9 10682.4 10787.8 10980.3 11311.7 11347.8 20566.0 20815.5 20880.7 20905.7 20963.8 7907.7 7939.3 7944.4 8056.2 8207.1 4539.7 4611.3 4635.8 4660.3 4750.3 3495.8 3630.1 3630.5 3637.6 3642.2 549.3 640.9 644.0 665.8 668.9 558.5 659.1 665.9 667.8 694.2 8734.2 9626.8 9715.8 9782.9 9783.8 613.3 623.4 660.9 671.9 676.6 4418.8 4685.5 4689.1 4694.9 4704.2 88610.6 122709.4 154645.0 159301.0 160045.0 137587.9 139211.0 139606.0 140459.0 141945.0 118735.0 120023.0 120361.4 122787.8 123803.4 9109.3 9172.5 9244.9 9261.8 9519.0 47775.0 53904.7 55000.0 55340.0 58260.0 63940.0 72083.6 75317.9 80184.0 93722.0 13148.7 13330.2 13449.3 13700.6 14005.9 14692.3 14723.9 14830.6 14977.6 15704.7 13648.7 13818.2 14239.7 14406.6 14453.9 13719.9 13867.7 13954.0 13977.0 14371.4 13356.2 13455.0 13713.1 13732.7 13995.3 11216.7 11402.3 11425.8 11448.5 11622.9 10754.7 10900.7 11384.3 11582.7 11598.5 21:59:33 INFO - PROCESS | 2249 | -------- Summary: end -------- 21:59:33 INFO - PROCESS | 2249 | 21:59:34 INFO - TEST-INFO | 2249: exit 0 21:59:34 INFO - TEST-OK | dromaeo_css | took 1113939ms 21:59:34 INFO - TEST-START | kraken 21:59:34 INFO - operating with platform_type : mac_ 21:59:34 INFO - Initialising browser for kraken test... 21:59:34 INFO - TEST-INFO | started process 2255 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpi5CfMe/profile http://localhost:52225/getInfo.html) 21:59:37 INFO - PROCESS | 2255 | __metrics Screen width/height:1600/1200 21:59:37 INFO - PROCESS | 2255 | colorDepth:24 21:59:37 INFO - PROCESS | 2255 | Browser inner width/height: 1024/689 21:59:37 INFO - PROCESS | 2255 | __metrics 21:59:37 ERROR - PROCESS | 2255 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 21:59:37 INFO - TEST-INFO | 2255: exit 0 21:59:37 INFO - Browser initialized. 21:59:37 INFO - Running cycle 1/1 for kraken test... 21:59:37 INFO - TEST-INFO | started process 2257 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpi5CfMe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:59:49 INFO - PROCESS | 2257 | RSS: Main: 239226880 21:59:49 INFO - PROCESS | 2257 | 21:59:52 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52225/tests/kraken/driver.html?testName=audio-beat-detection) 21:59:53 INFO - PROCESS | 2257 | RSS: Main: 251953152 21:59:53 INFO - PROCESS | 2257 | 21:59:56 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52225/tests/kraken/driver.html?testName=audio-dft) 21:59:56 INFO - PROCESS | 2257 | RSS: Main: 260653056 21:59:56 INFO - PROCESS | 2257 | 22:00:00 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52225/tests/kraken/driver.html?testName=audio-fft) 22:00:00 INFO - PROCESS | 2257 | RSS: Main: 263512064 22:00:00 INFO - PROCESS | 2257 | 22:00:02 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52225/tests/kraken/driver.html?testName=audio-oscillator) 22:00:03 INFO - PROCESS | 2257 | RSS: Main: 265908224 22:00:03 INFO - PROCESS | 2257 | 22:00:05 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:06 INFO - PROCESS | 2257 | RSS: Main: 266285056 22:00:06 INFO - PROCESS | 2257 | 22:00:08 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52225/tests/kraken/driver.html?testName=imaging-darkroom) 22:00:09 INFO - PROCESS | 2257 | RSS: Main: 266661888 22:00:09 INFO - PROCESS | 2257 | 22:00:12 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52225/tests/kraken/driver.html?testName=imaging-desaturate) 22:00:13 INFO - PROCESS | 2257 | RSS: Main: 266203136 22:00:13 INFO - PROCESS | 2257 | 22:00:16 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52225/tests/kraken/driver.html?testName=json-parse-financial) 22:00:16 INFO - PROCESS | 2257 | RSS: Main: 267235328 22:00:16 INFO - PROCESS | 2257 | 22:00:18 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:00:19 INFO - PROCESS | 2257 | RSS: Main: 266850304 22:00:19 INFO - PROCESS | 2257 | 22:00:21 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:00:21 INFO - PROCESS | 2257 | RSS: Main: 267223040 22:00:21 INFO - PROCESS | 2257 | 22:00:23 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:00:24 INFO - PROCESS | 2257 | RSS: Main: 267227136 22:00:24 INFO - PROCESS | 2257 | 22:00:27 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:00:28 INFO - PROCESS | 2257 | RSS: Main: 266678272 22:00:28 INFO - PROCESS | 2257 | 22:00:31 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:00:31 INFO - PROCESS | 2257 | RSS: Main: 267317248 22:00:31 INFO - PROCESS | 2257 | 22:00:33 INFO - PROCESS | 2257 | Cycle 1(1): loaded http://localhost:52225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52225/tests/kraken/driver.html?testName=ai-astar) 22:00:34 INFO - PROCESS | 2257 | RSS: Main: 268484608 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | __start_tp_report 22:00:34 INFO - PROCESS | 2257 | _x_x_mozilla_page_load 22:00:34 INFO - PROCESS | 2257 | _x_x_mozilla_page_load_details 22:00:34 INFO - PROCESS | 2257 | |i|pagename|runs| 22:00:34 INFO - PROCESS | 2257 | |0;ai-astar;104;117;114;118;117;117;119;114;117;116 22:00:34 INFO - PROCESS | 2257 | |1;audio-beat-detection;171;140;137;157;110;134;149;106;155;108 22:00:34 INFO - PROCESS | 2257 | |2;audio-dft;197;203;211;237;198;196;196;200;199;196 22:00:34 INFO - PROCESS | 2257 | |3;audio-fft;69;84;75;151;52;60;84;90;169;62 22:00:34 INFO - PROCESS | 2257 | |4;audio-oscillator;73;73;129;70;71;86;112;69;77;115 22:00:34 INFO - PROCESS | 2257 | |5;imaging-gaussian-blur;88;86;88;85;91;87;88;86;123;86 22:00:34 INFO - PROCESS | 2257 | |6;imaging-darkroom;95;95;95;153;152;94;96;113;151;111 22:00:34 INFO - PROCESS | 2257 | |7;imaging-desaturate;97;134;89;91;93;90;91;97;100;156 22:00:34 INFO - PROCESS | 2257 | |8;json-parse-financial;53;55;58;56;54;61;55;55;55;57 22:00:34 INFO - PROCESS | 2257 | |9;json-stringify-tinderbox;64;68;68;70;75;80;70;71;71;72 22:00:34 INFO - PROCESS | 2257 | |10;stanford-crypto-aes;102;85;88;75;91;109;108;107;109;91 22:00:34 INFO - PROCESS | 2257 | |11;stanford-crypto-ccm;142;136;138;126;164;134;156;138;184;139 22:00:34 INFO - PROCESS | 2257 | |12;stanford-crypto-pbkdf2;172;169;169;171;205;151;240;224;169;165 22:00:34 INFO - PROCESS | 2257 | |13;stanford-crypto-sha256-iterative;87;92;89;95;96;77;69;68;70;69 22:00:34 INFO - PROCESS | 2257 | __end_tp_report 22:00:34 INFO - PROCESS | 2257 | __start_cc_report 22:00:34 INFO - PROCESS | 2257 | _x_x_mozilla_cycle_collect,1061 22:00:34 INFO - PROCESS | 2257 | __end_cc_report 22:00:34 INFO - PROCESS | 2257 | __startTimestamp1471496434060__endTimestamp 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | ------- Summary: start ------- 22:00:34 INFO - PROCESS | 2257 | Number of tests: 14 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#0] ai-astar Cycles:10 Average:115.30 Median:117.00 stddev:4.27 (3.6%) stddev-sans-first:1.67 22:00:34 INFO - PROCESS | 2257 | Values: 104.0 117.0 114.0 118.0 117.0 117.0 119.0 114.0 117.0 116.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:144.50 stddev:22.54 (15.6%) stddev-sans-first:20.20 22:00:34 INFO - PROCESS | 2257 | Values: 171.0 140.0 137.0 157.0 110.0 134.0 149.0 106.0 155.0 108.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#2] audio-dft Cycles:10 Average:203.30 Median:199.50 stddev:12.70 (6.4%) stddev-sans-first:13.27 22:00:34 INFO - PROCESS | 2257 | Values: 197.0 203.0 211.0 237.0 198.0 196.0 196.0 200.0 199.0 196.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#3] audio-fft Cycles:10 Average:89.60 Median:72.00 stddev:39.20 (54.4%) stddev-sans-first:40.86 22:00:34 INFO - PROCESS | 2257 | Values: 69.0 84.0 75.0 151.0 52.0 60.0 84.0 90.0 169.0 62.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:72.00 stddev:22.44 (31.2%) stddev-sans-first:23.18 22:00:34 INFO - PROCESS | 2257 | Values: 73.0 73.0 129.0 70.0 71.0 86.0 112.0 69.0 77.0 115.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.50 stddev:11.44 (13.1%) stddev-sans-first:12.09 22:00:34 INFO - PROCESS | 2257 | Values: 88.0 86.0 88.0 85.0 91.0 87.0 88.0 86.0 123.0 86.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:94.50 stddev:26.09 (27.6%) stddev-sans-first:26.60 22:00:34 INFO - PROCESS | 2257 | Values: 95.0 95.0 95.0 153.0 152.0 94.0 96.0 113.0 151.0 111.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#7] imaging-desaturate Cycles:10 Average:103.80 Median:91.00 stddev:22.60 (24.8%) stddev-sans-first:23.84 22:00:34 INFO - PROCESS | 2257 | Values: 97.0 134.0 89.0 91.0 93.0 90.0 91.0 97.0 100.0 156.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:2.28 (4.1%) stddev-sans-first:2.17 22:00:34 INFO - PROCESS | 2257 | Values: 53.0 55.0 58.0 56.0 54.0 61.0 55.0 55.0 55.0 57.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.00 stddev:4.31 (6.1%) stddev-sans-first:3.77 22:00:34 INFO - PROCESS | 2257 | Values: 64.0 68.0 68.0 70.0 75.0 80.0 70.0 71.0 71.0 72.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#10] stanford-crypto-aes Cycles:10 Average:96.50 Median:80.00 stddev:12.08 (15.1%) stddev-sans-first:12.64 22:00:34 INFO - PROCESS | 2257 | Values: 102.0 85.0 88.0 75.0 91.0 109.0 108.0 107.0 109.0 91.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:140.50 stddev:17.33 (12.3%) stddev-sans-first:18.33 22:00:34 INFO - PROCESS | 2257 | Values: 142.0 136.0 138.0 126.0 164.0 134.0 156.0 138.0 184.0 139.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.50 Median:171.50 stddev:29.08 (17.0%) stddev-sans-first:30.55 22:00:34 INFO - PROCESS | 2257 | Values: 172.0 169.0 169.0 171.0 205.0 151.0 240.0 224.0 169.0 165.0 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - PROCESS | 2257 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.20 Median:88.00 stddev:11.72 (13.3%) stddev-sans-first:12.24 22:00:34 INFO - PROCESS | 2257 | Values: 87.0 92.0 89.0 95.0 96.0 77.0 69.0 68.0 70.0 69.0 22:00:34 INFO - PROCESS | 2257 | -------- Summary: end -------- 22:00:34 INFO - PROCESS | 2257 | 22:00:34 INFO - TEST-INFO | 2257: exit 0 22:00:34 INFO - TEST-OK | kraken | took 60402ms 22:00:34 INFO - SUITE-END | took 1174s 22:00:35 INFO - Completed test suite (00:19:34) 22:00:35 INFO - javascript benchmark 22:00:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7412.655430419652, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2828.2646511906905, 2977.80887644942, 3372.56156699629, 3400.4389275769486, 3423.5378223939774, 4724.952750472494, 5701.515371193444, 5817.73820178092, 5907.40925907409, 5919.37846526115, 5788.450097240766, 5836.387179346171, 5861.443162899528, 5861.8827623447505, 5936.079907614327, 5207.843764687056, 5310.522053015228, 5335.013022590813, 5373.140297552392, 5399.082156033483, 5375.731213439332, 5386.73066346683, 5413.729313534327, 5414.214938833887, 5453.2092846537225, 5173.224016397552, 5220.556252718524, 5277.366715994067, 5296.92054619181, 5317.73411329432, 5256.395514515842, 5267.26258323835, 5268.81559145428, 5361.356637203521, 5363.436839131874, 4202.390653355277, 5293.920591191135, 5308.575313974911, 5329.0, 5339.492748188916, 4524.366588677588, 5659.037963546207, 5827.446392592697, 5848.122781582754, 5867.911981320283, 6187.690615469209, 6234.906476402857, 6243.250809902841, 6281.24625044993, 6287.245530536365, 6164.260288765332, 6189.38106189382, 6263.4362907338555, 6276.937230627681, 6320.494360451153, 5939.524838012949, 6003.939960600425, 6030.306514750772, 6068.393160683941, 6078.1186727924205, 6333.904991425133, 6354.237491500957, 6371.617702937746, 6374.235091789015, 6379.808605741835, 5747.6838773867, 6082.695865206722, 6135.814547850547, 6245.531585131133, 6256.937430625636, 6172.475339596095, 6198.938010619926, 6231.158793562901, 6300.495960323163, 6330.746770129143, 5101.8724531886255, 5220.399654039758, 6193.659348735863, 6201.10084037812, 6295.6537390443045, 6207.751689932352, 6237.937620623827, 6305.936940630535, 6311.873762524724, 6337.049442583557, 4982.800687972513, 5019.598432125421, 5023.648344615842, 5046.571041461443, 5065.6200784941275, 4423.0, 4489.079738653568, 4509.594136527729, 4516.728996260234, 4527.411436513232, 5241.868953276198, 5586.86032849182, 5877.294724633071, 5966.105084237399, 6019.608725432833, 6196.225471816023, 6214.689265536705, 6249.187605611332, 6268.686565671698, 6285.277193122758, 4836.613070954315, 5958.255218097738, 5970.402959704082, 5981.764735190058, 6008.158857759917, 5541.085720856014, 5555.416681248411, 5557.916631250535, 5565.276514053228, 5569.331680198402, 6107.541934354852, 6206.844828879314, 6284.874302514016, 6296.464800491918, 6326.873462530815, 6296.307406185224, 6299.370062993664, 6317.905231421624, 6326.493880489642, 6336.20797400325, 6344.524160687874, 6375.6174629522375, 6386.233651961795, 6395.712192951235, 6396.296407395276, 6102.246889800232, 6184.474319682698, 6190.380961903774, 6247.437730604267, 6311.558190926775, 6282.528810339334, 6302.054691796267, 6312.4634406076, 6313.55805093639, 6325.715342809676, 5367.060764366299, 6246.3753624637175, 6258.499320054294, 6263.467605253604, 6272.278687950944, 6072.514198864169, 6161.199044124235, 6179.598326108789, 6180.165677633642, 6265.4361107500545, 4727.841678788719, 5025.422076461254, 5292.391374991771, 6068.120122582289, 6161.537884658758, 6180.81457556274, 6225.595336303126, 6239.188905442264, 6274.560780745486, 6280.905786413299, 5992.730327135202, 6089.69551522431, 6107.877842443215, 6122.693865306628, 6165.630062196283], "value": 5719.292276323247, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [457.19533620827343, 527.0, 527.6412039812927, 540.8458589302049, 554.5037191713415, 38250.426243606336, 40642.59357406425, 40651.39022914655, 40731.38902916459, 40739.0, 41691.37462938058, 42228.57771422285, 42238.0, 42335.364969525406, 42398.36402453966, 9692.56383462744, 9910.603575856992, 9912.157466615346, 9917.256205784559, 9926.354786938862, 8724.52015139167, 9413.435193888354, 9800.0, 9845.803083938317, 9896.109350158484, 9837.90162098377, 9850.261230407712, 9873.40759554429, 9875.160611348045, 9892.258080643944, 9822.410655360665, 9825.754356141118, 9865.309428340019, 9874.456904870229, 9900.603975840957, 9729.756756081084, 9835.90164098357, 9841.852372214422, 9862.408255504693, 9880.258980576486, 39798.0050498737, 40026.79986600077, 40151.59848401508, 40194.39708404347, 40207.396889046686, 3354.312365964996, 3920.529536455615, 4154.273002224599, 4178.143480586473, 4180.101278225196, 28165.85917070422, 29723.959661411962, 30230.84884575585, 30415.847920760254, 30480.085597432113, 2638.854862982535, 2726.2366537369567, 3227.4190645683766, 3389.5254664347012, 3439.3465241604017, 495414.0, 504035.0, 504273.0, 505105.0, 506335.468322656, 60305.0, 60318.095228571605, 60651.11535500357, 60700.69649651724, 60715.39284607186, 58172.70913645405, 58720.41279587235, 58883.0, 59165.112523312186, 59333.11000334998, 16241.918790405973, 16390.918045409697, 16466.341346346013, 16542.007479551266, 16543.338266469207, 12596.929261012734, 12764.0, 12825.679358016125, 12826.9358653208, 12836.0, 12829.679258018437, 15565.754739620803, 15849.286782094834, 16256.59358516023, 16425.01449913009, 6039.275286965592, 7099.822504437327, 7188.784336469915, 7230.530015548972, 7287.70849166038, 804.830985493053, 915.1062230210545, 932.8181004704153, 953.1374106433689, 1038.3510306058713, 28883.71116288852, 29548.852255739013, 30406.695933040828, 30650.693493064784, 31131.68868311333, 894.9776255593532, 1031.9071283584512, 1055.9524821383056, 1128.4245035032193, 1156.8258217908829, 15598.766018509732, 17173.398931037354, 17229.0, 17429.389971351196, 17430.0, 612714.0, 646384.0, 649755.7512212408, 653642.0, 653846.0, 59712.0, 60625.69687151536, 60818.391816082156, 60841.69579152076, 60927.0, 1163.2729544035146, 1311.0036372356888, 1381.1229869033236, 1393.3451277899371, 1402.2848347342929, 27000.729992700606, 29671.703282966893, 30930.987956623318, 31625.73497060092, 32435.35129297448, 51499.48500515097, 52052.47947520476, 52170.0, 52253.0, 52279.73860130675, 544497.9951804198, 554093.0, 554459.0, 554503.0, 555397.0, 25988.220353389428, 26062.86968565145, 26457.60313595259, 26476.94092236289, 26558.336041599116, 47623.52376476191, 47717.52282477131, 48730.512694872596, 48764.2685359727, 48959.166533354495, 39399.80300098481, 39569.208615828094, 39677.603223968545, 40112.59887401089, 41103.58896410998, 39233.41149882697, 39724.404133938595, 40406.989825253426, 40602.593974059884, 40825.775226743244, 32937.83531082329, 37721.0, 38467.2306553873, 39032.804835975636, 40253.0, 32546.51180232251, 33668.83165584156, 34094.0, 34499.65500344965, 35363.292734144656, 21684.79564904443, 22189.55620887541, 23987.880060599586, 25255.621165682896, 25601.871990639927], "value": 19979.09242923189, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.7363535072424, 369.6488336080723, 370.6108585984716, 385.5604610743751, 394.4773175542405, 17531.47405577833, 20589.970501474923, 21452.678209826827, 22292.442688932766, 22471.66292505614, 20999.580008399862, 21131.260405885798, 21152.57694846106, 21188.8940555297, 21503.0, 5874.794382196624, 5964.3439221685685, 6119.479844213225, 6177.752889884399, 6206.906896396557, 3693.722970777189, 6096.847578810521, 6193.0, 6202.565820392574, 6590.406863382294, 6782.287859774727, 6948.583085014915, 6954.930450695504, 6959.860802783941, 6970.860582788341, 6742.460603151761, 6882.754296122656, 6942.548734332252, 6946.652667366637, 6950.165980082372, 5945.316288626776, 5965.105234214859, 5996.190514280604, 6012.3085845127935, 6035.185249991283, 26881.865590672118, 26987.73012269872, 27010.324741881414, 27019.729802701917, 27060.45879082427, 2241.2939923923914, 2707.986460067687, 3039.316153865385, 3152.917495005059, 3246.3345014272254, 13121.606351809365, 15143.848561514355, 15993.600159995976, 16322.591935201595, 16733.74899376498, 1847.4642353717406, 1880.7178923161498, 1882.2471011595335, 1898.3545594497937, 1914.1290712725815, 100474.49762751213, 108510.45744771305, 109992.0, 110263.0, 110324.0, 10498.737531561772, 10617.575296988189, 10658.467076646137, 11003.61487347939, 11186.496607652674, 10240.078392944672, 12205.38973051344, 13638.590842274747, 13639.249841258827, 13675.24786136772, 6680.899786503206, 7012.333828286304, 7148.35664790161, 8554.828903421896, 8618.956905215558, 8659.740207793777, 8712.825743485095, 8754.86867696985, 8875.28997680184, 8882.378233523592, 5500.80747173847, 6618.503612229102, 6743.291954344723, 6843.555168914005, 6867.759628412981, 1561.960950976212, 1641.3352592200179, 1804.7292906063933, 1865.6455273498264, 1890.366727146394, 759.8746206875803, 868.3574155125289, 873.1835733589114, 919.6183583812776, 992.4591097851688, 16227.918860405622, 21037.368878933656, 21631.0, 21917.671234931488, 22136.557268854533, 890.5235698901057, 920.5259291464768, 925.4956048953337, 1031.504877658713, 1049.7847941172042, 10914.181436392302, 11186.272892261977, 11379.658610241706, 11564.959153676042, 11568.88431115678, 455023.0, 566220.0, 583239.0, 598878.0168297479, 610446.0, 131838.38565650157, 134550.0, 134718.32640836734, 136519.95220071706, 137993.0, 950.3157726436955, 965.7633879699378, 985.8816941966867, 987.2299606307092, 988.17981075707, 18458.98475583856, 18901.243950241835, 19021.809781902004, 19064.809351906304, 19095.52261193481, 41785.0, 43100.0, 46433.76783116063, 52072.69818254574, 55422.44577554173, 50729.47811565659, 69276.61446771138, 76116.61941690255, 77555.0, 78838.0, 6586.868262634816, 6604.877170880865, 7314.634268286671, 7420.220876807857, 7441.144268409203, 11401.714957125807, 12277.0, 12662.0, 12877.806832897326, 13133.802992955305, 8141.755747327589, 10630.8936910633, 11017.504212310305, 11146.665600032013, 11492.54029838797, 9281.907180928105, 10357.13571557127, 10791.730206744895, 11151.776964460827, 11534.826977595176, 10405.895941040795, 10583.153347732008, 11346.978771910568, 11739.823902641638, 11863.0, 7920.881186782088, 7945.284924356835, 8171.79570510742, 8282.461639993382, 8298.08721040673, 9029.0, 10090.2432317575, 11334.659960201207, 11335.603253886075, 11574.421278935852], "value": 9736.03843314733, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1361.8774310312072, 1507.8341382447932, 1699.286299754103, 1826.8629852761046, 1852.2498388152803, 7883.605819709021, 8383.245507904287, 8563.10087440819, 8953.686620968267, 8981.865272020917, 8597.0, 8809.911900880988, 8814.030456649763, 8816.647334106645, 8820.0, 2316.814654827614, 2357.6227803551437, 2367.1596583212886, 2372.489914668346, 2374.536965291769, 2342.9882850585723, 2345.319857241398, 2379.9881000594974, 2380.642903564462, 2391.222852572912, 2343.7773411525964, 2352.4001379648166, 2359.445530300378, 2366.881655917206, 2372.003758421467, 2318.594246006942, 2333.88330583471, 2348.53029394121, 2354.9058037678474, 2358.599038163508, 2226.421130506064, 2335.2410466598253, 2340.461693810416, 2346.5424242272766, 2369.6563998220163, 8838.955805220998, 8899.599518021705, 8920.8661870072, 8921.375503714742, 8925.241354484877, 4157.9605098725315, 4287.421198138242, 4963.957568910533, 5076.593872490192, 5127.461616530285, 3509.7543171977973, 3531.5055892175114, 3668.3580373434543, 3685.4656074869263, 3690.225052738928, 1058.841173823925, 1077.2297807067985, 1098.0995583621354, 1122.1079242002545, 1123.7752449510049, 11520.423978801027, 11571.942140289244, 11607.941960290145, 11671.358075305854, 11710.765784684343, 4530.116627257719, 4631.0, 4809.95190048102, 4845.248986407112, 4853.223484242504, 9816.0, 9934.155596774355, 9961.203103751683, 9973.750656233653, 9975.102240798218, 4982.352294201731, 5122.847359344192, 5345.625806193529, 5345.786168553292, 5366.7853285868905, 3659.597444281127, 4756.191447453941, 4888.315635810989, 4906.1414252505665, 4911.386076740408, 3845.615438456188, 3917.7845218513257, 3979.621935916083, 3991.860284890015, 4019.33680942647, 1283.9807402888964, 1297.1633296523878, 1305.5756879014168, 1311.4819646239873, 1312.4946895445323, 826.7643721539332, 898.3397203055749, 909.4406939732017, 922.9446233226028, 949.3259785552335, 5413.133898576209, 5632.239647647597, 5903.0260007099205, 6000.969995149996, 6044.607100538539, 909.554318383987, 922.6032805893396, 927.3601215161652, 962.9181519570775, 969.9466529340813, 4006.979965100214, 4008.1983603278877, 4059.06641472463, 4148.357004664282, 4149.709520333608, 10354.741131471774, 10861.402622855661, 10874.130069594414, 10907.400092994803, 10956.890431095746, 10834.079103276152, 10835.128690896918, 10839.807621161666, 10854.511546980404, 10908.836367454494, 8187.95906020478, 8306.750797476085, 8307.750767476986, 8319.376046796393, 8329.958755155605, 5483.890322193613, 5602.3837377887585, 6032.185654936703, 6081.209442772411, 6091.634501929899, 9122.954385228031, 9725.854112188465, 10023.797144342725, 10095.697129086138, 10140.54367553447, 10118.544665490217, 10322.071013608811, 10331.94834025825, 10362.689119326433, 10398.428086455318, 6949.096617439701, 7432.405407567274, 7488.101427828696, 7532.5857077859055, 7717.459777815499, 8503.872441913252, 8559.486430813922, 8581.0, 8611.052784193858, 8619.612117454855, 7373.967644529663, 7445.218252083453, 7552.0, 7610.543367397974, 7684.807879803049, 7333.853322933404, 7458.664360103917, 7493.175750667531, 7589.43079269046, 7639.236076392316, 5743.62666426681, 6657.367550082734, 6783.0, 6810.28492008332, 6822.931770682229, 4893.853184404331, 4956.008798240294, 4986.351774269322, 5099.2860999460845, 5149.871253218699, 4960.727160006234, 4991.401031876198, 5115.616328775282, 5140.30605868203, 5178.964207158659], "value": 4595.487005358673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [263.27467826138985, 266.41920613063536, 308.4524968181478, 310.20277885833417, 315.35667238832775, 4466.3523789050605, 4900.705957642544, 5269.420363759983, 5485.478879506445, 5576.749046292922, 5223.14578324695, 5408.378036525791, 5506.449355064502, 5556.888862222753, 5583.3300003999575, 4078.4697989261354, 4180.895477613054, 4205.11692544566, 4213.810378532958, 4217.683673724468, 3327.7005069543734, 3527.294541091779, 4068.125353049094, 4191.2874811282, 4215.515215750182, 3372.8700885203484, 4071.084006098634, 4076.9184616307657, 4094.6724262058965, 4094.89762755932, 4095.385692146202, 4095.8361665533344, 4118.8970275743195, 4134.586541345871, 4144.48193975753, 3548.6628770267043, 3568.7323450741037, 3573.1781690211137, 3576.517170182044, 3598.298331825269, 4093.385992101179, 4949.663590830492, 5225.909636145534, 5289.920651190235, 5361.463853614608, 4767.022760334124, 4777.211760059586, 4798.47216806151, 4809.416984346649, 4810.422749270075, 5058.898822023576, 5474.863128421821, 5759.041925745225, 5812.052962257649, 5865.149553314788, 3210.678932106794, 3854.2291541691775, 3961.1483531040676, 4026.0, 4037.737547059461, 4958.528939750718, 6002.96998515009, 6018.578699491038, 6023.728932198018, 6070.6021121656695, 4075.8369665213654, 4122.525909520384, 4130.380442933584, 4131.607497287753, 4141.81361838718, 3965.7111438781935, 4148.668106551469, 4179.2477354076555, 4194.307939189999, 4202.663786897041, 4766.666333356632, 4786.880327991758, 4823.710577365369, 4827.3345695734915, 4844.660873738804, 4591.347115038583, 5034.684045339185, 5731.627444216196, 5771.913421298684, 5877.0596704527925, 1212.6422705301957, 1252.949882004728, 1392.7632302508598, 1399.3213291553589, 1419.737348590514, 941.0899550820856, 949.5252373813094, 972.644984580623, 972.8451479971897, 974.9512524373753, 4942.0, 4963.677360971526, 5160.974195129001, 5322.509697284767, 5489.725513724298, 4326.2212801696, 4766.971908737111, 5497.092979658311, 5939.713210414022, 5983.640981541122, 4738.857834264978, 4802.663813533089, 5058.013687330935, 5074.594032477393, 5337.679739215582, 2156.202205184092, 2403.651470536762, 2481.33004088895, 2541.0, 2543.0717788007246, 4589.862304130881, 4862.881537246453, 5094.18493041119, 5100.7959681613065, 5130.615203859726, 4453.374518300861, 4686.390769199982, 5033.421156566968, 5038.5969122470115, 5063.645544811901, 5342.519173274346, 5848.912266316009, 6217.911865423533, 6239.594426362272, 6247.781327653511, 4981.480648402127, 5240.873212259383, 5251.26482292487, 6047.455728984412, 6104.908426373519, 5709.34342550612, 5866.7066646668345, 5884.705764711833, 5930.584859059824, 6010.158577799024, 6187.783427580193, 6187.907181392193, 6194.194754681863, 6212.720427580679, 6221.502279817513, 3727.7017838572306, 3966.3852102924093, 3979.900502487461, 3986.3023970805575, 4016.3090729210912, 4921.8523444296725, 5640.492355688008, 5931.258592675916, 5966.210136958982, 5992.790252341147, 4924.4090709115135, 5202.60980426462, 5897.557683173865, 5917.201177840936, 5945.31628862669, 5832.679202643895, 5839.211706419579, 5860.531157507475, 5869.207656966255, 5943.29580041089, 5355.4376790436445, 5575.076598573486, 5658.632188907708, 5785.0, 5814.215080964185, 4837.7581120943105, 4846.345743324606, 5042.546170844642, 5345.305110335631, 5945.40545945402, 5105.825660098272, 5738.426157384395, 5788.044972579645, 5807.941920580909, 5815.331236907809], "value": 4132.658221042838, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.3148864970156, 718.9784306470806, 740.6704016712565, 775.8564665536876, 853.5433543054467, 15617.765733514007, 15937.92031039846, 16315.510534683963, 16381.508554743346, 16408.26162822673, 14285.428582856674, 14897.404103835861, 15032.398704051824, 15046.54860354191, 15059.472918447857, 678.4301187002917, 860.5912191708935, 884.0319849764497, 890.0254221627308, 893.3121496447732, 854.7093988044064, 882.2500874256863, 887.2591386192505, 888.3559419420933, 891.888513935758, 904.5612877754284, 928.1878356438117, 928.3223247029672, 928.3733479901074, 932.664240873285, 893.4907102951321, 894.5080205886801, 921.037515795988, 923.0953665407905, 923.5013092929844, 688.3667026335783, 689.3898899473952, 689.9103116594811, 693.0816667914983, 694.0456871801273, 11453.65639030822, 14328.856711432856, 14882.181480018595, 15181.772273415907, 15219.239038048054, 12802.911752501048, 13695.726085478334, 14662.120272783666, 14675.119492830465, 14948.0, 9753.927068022513, 10875.619353322596, 11629.185956983014, 11869.5845645402, 11967.341796201206, 3732.496113024734, 3877.476540667002, 3925.0, 3931.6461518463475, 3974.125692347679, 94438.0556194436, 99708.00875973732, 109823.45088274588, 111982.0, 113923.86076139132, 10682.412467314218, 10787.78424431507, 10980.341179529254, 11311.717207069889, 11347.829782553268, 20566.0, 20815.479613009495, 20880.686789698168, 20905.686414703792, 20963.790362096184, 7907.683692652345, 7939.325157361689, 7944.404169687296, 8056.194380561897, 8207.138250483733, 4539.682222244412, 4611.308303754464, 4635.814567417333, 4660.347551342815, 4750.287456881495, 3495.8252087395526, 3630.0561853917643, 3630.5098811660087, 3637.5998640149564, 3642.235130622546, 549.2667289169004, 640.8846407646669, 644.0275184471482, 665.816900352407, 668.9498287628447, 558.48340285236, 659.0970370592319, 665.8568407792251, 667.813012356541, 694.1739330197049, 8734.213920747035, 9626.759331016641, 9715.805683886283, 9782.853257201148, 9783.804323913624, 613.2793967088653, 623.382850977529, 660.9325938609112, 671.9462443004547, 676.6028151866478, 4418.8453404130705, 4685.531446855287, 4689.132510485503, 4694.906101877943, 4704.200320695812, 88610.55694721485, 122709.38645306895, 154645.0, 159301.0, 160045.0, 137587.93618095736, 139211.0, 139606.0, 140459.0, 141945.0, 118735.0, 120023.0, 120361.39819300847, 122787.77212227942, 123803.38098309451, 9109.316801240066, 9172.495512746596, 9244.907550924674, 9261.76845578839, 9518.95240523793, 47775.04449911052, 53904.65238369072, 55000.0, 55340.0, 58260.0, 63940.0, 72083.63958180175, 75317.87023194766, 80184.0, 93722.0, 13148.698977678676, 13330.200187988752, 13449.260290684106, 13700.588982330546, 14005.949553783303, 14692.265386730835, 14723.92638036803, 14830.62923426923, 14977.625559361104, 15704.685906282039, 13648.691013500353, 13818.239996800272, 14239.71520569562, 14406.567802965928, 14453.927730361702, 13719.862801372257, 13867.722645547234, 13954.023218374616, 13977.0, 14371.425142994163, 13356.198628082346, 13455.0, 13713.108647937852, 13732.725345492834, 13995.300234988006, 11216.719582010515, 11402.315861048364, 11425.828612570653, 11448.542058317908, 11622.88377116218, 10754.677359679223, 10900.727481813017, 11384.32291744429, 11582.71043223926, 11598.47806848677], "value": 7851.196950860754, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 117.0, 114.0, 118.0, 117.0, 117.0, 119.0, 114.0, 117.0, 116.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 140.0, 137.0, 157.0, 110.0, 134.0, 149.0, 106.0, 155.0, 108.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 203.0, 211.0, 237.0, 198.0, 196.0, 196.0, 200.0, 199.0, 196.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 84.0, 75.0, 151.0, 52.0, 60.0, 84.0, 90.0, 169.0, 62.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 129.0, 70.0, 71.0, 86.0, 112.0, 69.0, 77.0, 115.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 85.0, 91.0, 87.0, 88.0, 86.0, 123.0, 86.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 153.0, 152.0, 94.0, 96.0, 113.0, 151.0, 111.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 134.0, 89.0, 91.0, 93.0, 90.0, 91.0, 97.0, 100.0, 156.0], "value": 103.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 58.0, 56.0, 54.0, 61.0, 55.0, 55.0, 55.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 68.0, 68.0, 70.0, 75.0, 80.0, 70.0, 71.0, 71.0, 72.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 85.0, 88.0, 75.0, 91.0, 109.0, 108.0, 107.0, 109.0, 91.0], "value": 96.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 138.0, 126.0, 164.0, 134.0, 156.0, 138.0, 184.0, 139.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 169.0, 171.0, 205.0, 151.0, 240.0, 224.0, 169.0, 165.0], "value": 183.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 89.0, 95.0, 96.0, 77.0, 69.0, 68.0, 70.0, 69.0], "value": 81.2, "unit": "score"}]}]} 22:00:35 INFO - Return code: 0 22:00:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:00:35 ERROR - # TBPL SUCCESS # 22:00:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:35 INFO - 2016-08-17 22:00:35.413 screenresolution[2262:20012] starting screenresolution argv=screenresolution get 22:00:35 INFO - 2016-08-17 22:00:35.416 screenresolution[2262:20012] Display 0: 1600x1200x32@60 22:00:35 INFO - 2016-08-17 22:00:35.422 screenresolution[2263:20015] starting screenresolution argv=screenresolution list 22:00:35 INFO - Available Modes on Display 0 22:00:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:35 INFO - Intel Iris: 22:00:35 INFO - Chipset Model: Intel Iris 22:00:35 INFO - Type: GPU 22:00:35 INFO - Bus: Built-In 22:00:35 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:35 INFO - Vendor: Intel (0x8086) 22:00:35 INFO - Device ID: 0x0a2e 22:00:35 INFO - Revision ID: 0x0009 22:00:35 INFO - Displays: 22:00:35 INFO - Display: 22:00:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:35 INFO - Display Serial Number: 1600x1200 60 22:00:35 INFO - Main Display: Yes 22:00:35 INFO - Mirror: Off 22:00:35 INFO - Online: Yes 22:00:35 INFO - Rotation: Supported 22:00:35 INFO - Return code: 0 22:00:35 INFO - Running post-action listener: _resource_record_post_action 22:00:35 INFO - [mozharness: 2016-08-18 05:00:35.658752Z] Finished run-tests step (success) 22:00:35 INFO - Running post-run listener: _resource_record_post_run 22:00:35 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 147456; Write bytes: 710873600; Read time: 2; Write time: 2094 22:00:35 INFO - TinderboxPrint: CPU usage
54.5% 22:00:35 INFO - TinderboxPrint: I/O read bytes / time
147,456 / 2 22:00:35 INFO - TinderboxPrint: I/O write bytes / time
710,873,600 / 2,094 22:00:35 INFO - TinderboxPrint: CPU idle
2,200.6 (45.5%) 22:00:35 INFO - TinderboxPrint: CPU system
982.6 (20.3%) 22:00:35 INFO - TinderboxPrint: CPU user
1,654.4 (34.2%) 22:00:35 INFO - TinderboxPrint: Swap in / out
404,766,720 / 0 22:00:35 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402739712; Write bytes: 398338048; Read time: 29899; Write time: 745 22:00:35 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 102400; Write bytes: 300616192; Read time: 1; Write time: 1315 22:00:36 INFO - Running post-run listener: _upload_blobber_files 22:00:36 INFO - Blob upload gear active. 22:00:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:00:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:00:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:00:36 INFO - (blobuploader) - INFO - Open directory for files ... 22:00:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:00:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:00:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:37 INFO - (blobuploader) - INFO - Done attempting. 22:00:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:00:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:00:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:38 INFO - (blobuploader) - INFO - Done attempting. 22:00:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:00:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:00:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:41 INFO - (blobuploader) - INFO - Done attempting. 22:00:41 INFO - (blobuploader) - INFO - Iteration through files over. 22:00:41 INFO - Return code: 0 22:00:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:00:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:00:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f49e0eb6ec5331def0dc2f6bf73fe95b44e23cd29f910fa8d6ac32d15b0974946d3c1e2478e801bb0eb5d12e6577bc2cfdf088d3bb74a3cf6bdc3069febf101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f38d4af4625123efe3ace1c9ddb3cdaf583e91b3945172a3567c3e8c2e4c1be033b46600a7d0e1ef84b2c60aef9d74376dc19c234db446b55628284f4fe39235", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e3cd87b3ec8301b907bb17148d0bd0f50a098439d9a2375672429f25db30fee299a5c2a1f120221afa996b98bc8c0ec92ae1c9896a25a9a9e67f6d1370533ee"} 22:00:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:00:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:00:41 INFO - Contents: 22:00:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f49e0eb6ec5331def0dc2f6bf73fe95b44e23cd29f910fa8d6ac32d15b0974946d3c1e2478e801bb0eb5d12e6577bc2cfdf088d3bb74a3cf6bdc3069febf101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f38d4af4625123efe3ace1c9ddb3cdaf583e91b3945172a3567c3e8c2e4c1be033b46600a7d0e1ef84b2c60aef9d74376dc19c234db446b55628284f4fe39235", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e3cd87b3ec8301b907bb17148d0bd0f50a098439d9a2375672429f25db30fee299a5c2a1f120221afa996b98bc8c0ec92ae1c9896a25a9a9e67f6d1370533ee"} 22:00:41 INFO - Running post-run listener: copy_logs_to_upload_dir 22:00:41 INFO - Copying logs to upload dir... 22:00:41 INFO - mkdir: /builds/slave/test/build/upload/logs 22:00:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.068163 ========= master_lag: 2.79 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-08-17 22:00:44.013236) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 22:00:44.016949) ========= 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.thzEs3QGa3/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.acV8jGuAxV/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f49e0eb6ec5331def0dc2f6bf73fe95b44e23cd29f910fa8d6ac32d15b0974946d3c1e2478e801bb0eb5d12e6577bc2cfdf088d3bb74a3cf6bdc3069febf101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f38d4af4625123efe3ace1c9ddb3cdaf583e91b3945172a3567c3e8c2e4c1be033b46600a7d0e1ef84b2c60aef9d74376dc19c234db446b55628284f4fe39235", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e3cd87b3ec8301b907bb17148d0bd0f50a098439d9a2375672429f25db30fee299a5c2a1f120221afa996b98bc8c0ec92ae1c9896a25a9a9e67f6d1370533ee"} build_url:https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/Z9YLd5rXReORn18maaceuA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9f49e0eb6ec5331def0dc2f6bf73fe95b44e23cd29f910fa8d6ac32d15b0974946d3c1e2478e801bb0eb5d12e6577bc2cfdf088d3bb74a3cf6bdc3069febf101", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f38d4af4625123efe3ace1c9ddb3cdaf583e91b3945172a3567c3e8c2e4c1be033b46600a7d0e1ef84b2c60aef9d74376dc19c234db446b55628284f4fe39235", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9e3cd87b3ec8301b907bb17148d0bd0f50a098439d9a2375672429f25db30fee299a5c2a1f120221afa996b98bc8c0ec92ae1c9896a25a9a9e67f6d1370533ee"}' ========= master_lag: 0.28 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 22:00:44.311924) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 22:00:44.312299) ========= 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.thzEs3QGa3/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.acV8jGuAxV/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.005282 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 22:00:44.342171) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 22:00:44.345523) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 22:00:44.345881) ========= ========= Total master_lag: 5.98 =========