builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0018 starttime: 1473306639.4 results: success (0) buildid: 20160907180916 builduid: f25b6be883c242b4b30a3402f2ac020f revision: fb7c6b0343295392bac590c19b14e7e5dcccdc33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.404884) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.405316) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.405603) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.430940) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.431319) ========= 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.MQORKFtbAb/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.atbrQeBWxR/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-07 20:50:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-09-07 20:50:39 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.548387) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.548696) ========= 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.MQORKFtbAb/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.atbrQeBWxR/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.028513 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:39.597968) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-07 20:50:39.598314) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fb7c6b0343295392bac590c19b14e7e5dcccdc33 --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 fb7c6b0343295392bac590c19b14e7e5dcccdc33 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MQORKFtbAb/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.atbrQeBWxR/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-07 20:50:39,688 truncating revision to first 12 chars 2016-09-07 20:50:39,688 Setting DEBUG logging. 2016-09-07 20:50:39,688 attempt 1/10 2016-09-07 20:50:39,688 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fb7c6b034329?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 20:50:41,087 unpacking tar archive at: fx-team-fb7c6b034329/testing/mozharness/ program finished with exit code 0 elapsedTime=1.656734 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-07 20:50:41.314445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:41.314776) ========= script_repo_revision: fb7c6b0343295392bac590c19b14e7e5dcccdc33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:41.315162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:41.315443) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 20:50:41.334451) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-07 20:50:41.334844) ========= /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.MQORKFtbAb/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.atbrQeBWxR/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:50:41 INFO - MultiFileLogger online at 20160907 20:50:41 in /builds/slave/test 20:50:41 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 20:50:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:50:41 INFO - {'append_to_log': False, 20:50:41 INFO - 'base_work_dir': '/builds/slave/test', 20:50:41 INFO - 'blob_upload_branch': 'Fx-Team', 20:50:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:50:41 INFO - 'branch': 'Fx-Team', 20:50:41 INFO - 'buildbot_json_path': 'buildprops.json', 20:50:41 INFO - 'config_files': ('talos/mac_config.py',), 20:50:41 INFO - 'default_actions': ('clobber', 20:50:41 INFO - 'read-buildbot-config', 20:50:41 INFO - 'download-and-extract', 20:50:41 INFO - 'populate-webroot', 20:50:41 INFO - 'create-virtualenv', 20:50:41 INFO - 'install', 20:50:41 INFO - 'run-tests'), 20:50:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:50:41 INFO - 'download_minidump_stackwalk': True, 20:50:41 INFO - 'download_symbols': 'ondemand', 20:50:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:50:41 INFO - 'tooltool.py': '/tools/tooltool.py', 20:50:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:50:41 INFO - '/tools/misc-python/virtualenv.py')}, 20:50:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:50:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:50:41 INFO - 'installer_path': 'installer.exe', 20:50:41 INFO - 'log_level': 'info', 20:50:41 INFO - 'log_name': 'talos', 20:50:41 INFO - 'log_to_console': True, 20:50:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:50:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:50:41 INFO - 'opt_config_files': (), 20:50:41 INFO - 'pip_index': False, 20:50:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:50:41 INFO - 'cmd': ('bash', 20:50:41 INFO - '-c', 20:50:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:50:41 INFO - 'enabled': True, 20:50:41 INFO - 'halt_on_failure': False, 20:50:41 INFO - 'name': 'check_screen_resolution'},), 20:50:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:50:41 INFO - 'cmd': ('bash', 20:50:41 INFO - '-c', 20:50:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:50:41 INFO - 'enabled': True, 20:50:41 INFO - 'halt_on_failure': False, 20:50:41 INFO - 'name': 'check_screen_resolution'},), 20:50:41 INFO - 'run_cmd_checks_enabled': True, 20:50:41 INFO - 'sps_profile': False, 20:50:41 INFO - 'sps_profile_interval': 0, 20:50:41 INFO - 'suite': 'dromaeojs-e10s', 20:50:41 INFO - 'system_bits': '32', 20:50:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:50:41 INFO - 'title': 't-yosemite-r7-0018', 20:50:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:50:41 INFO - 'use_talos_json': True, 20:50:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:50:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:50:41 INFO - 'work_dir': 'build'} 20:50:41 INFO - [mozharness: 2016-09-08 03:50:41.538569Z] Running clobber step. 20:50:41 INFO - Running pre-action listener: _resource_record_pre_action 20:50:41 INFO - Running main action method: clobber 20:50:41 INFO - rmtree: /builds/slave/test/build 20:50:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:50:43 INFO - Running post-action listener: _resource_record_post_action 20:50:43 INFO - [mozharness: 2016-09-08 03:50:43.682599Z] Finished clobber step (success) 20:50:43 INFO - [mozharness: 2016-09-08 03:50:43.682708Z] Running read-buildbot-config step. 20:50:43 INFO - Running pre-action listener: _resource_record_pre_action 20:50:43 INFO - Running main action method: read_buildbot_config 20:50:43 INFO - Using buildbot properties: 20:50:43 INFO - { 20:50:43 INFO - "project": "", 20:50:43 INFO - "product": "firefox", 20:50:43 INFO - "script_repo_revision": "production", 20:50:43 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 20:50:43 INFO - "repository": "", 20:50:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 20:50:43 INFO - "buildid": "20160907180916", 20:50:43 INFO - "pgo_build": "False", 20:50:43 INFO - "basedir": "/builds/slave/test", 20:50:43 INFO - "buildnumber": 93, 20:50:43 INFO - "slavename": "t-yosemite-r7-0018", 20:50:43 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 20:50:43 INFO - "platform": "yosemite_r7", 20:50:43 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 20:50:43 INFO - "branch": "fx-team", 20:50:43 INFO - "repo_path": "integration/fx-team", 20:50:43 INFO - "revision": "fb7c6b0343295392bac590c19b14e7e5dcccdc33", 20:50:43 INFO - "stage_platform": "macosx64", 20:50:43 INFO - "builduid": "f25b6be883c242b4b30a3402f2ac020f", 20:50:43 INFO - "slavebuilddir": "test" 20:50:43 INFO - } 20:50:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 20:50:43 INFO - Running post-action listener: _resource_record_post_action 20:50:43 INFO - [mozharness: 2016-09-08 03:50:43.685599Z] Finished read-buildbot-config step (success) 20:50:43 INFO - [mozharness: 2016-09-08 03:50:43.685705Z] Running download-and-extract step. 20:50:43 INFO - Running pre-action listener: _resource_record_pre_action 20:50:43 INFO - Running main action method: download_and_extract 20:50:43 INFO - mkdir: /builds/slave/test/build/tests 20:50: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')]} 20:50:43 INFO - trying https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 20:50:43 INFO - Downloading https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/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 20:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/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 20:50:44 INFO - Downloaded 1199 bytes. 20:50:44 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 20:50:44 INFO - Using the following test package requirements: 20:50:44 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:50:44 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 20:50:44 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 20:50:44 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'jsshell-mac.zip'], 20:50:44 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 20:50:44 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 20:50:44 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 20:50:44 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 20:50:44 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 20:50:44 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 20:50:44 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 20:50:44 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:50:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:50:45 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:50:52 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 20:50:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 20:50:52 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:50:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 20:50:59 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 20:51: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')]} 20:51:00 INFO - trying https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:51:00 INFO - Downloading https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 20:51:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/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 20:51:03 INFO - Downloaded 111446428 bytes. 20:51:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:51:03 INFO - mkdir: /builds/slave/test/properties 20:51:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:51:03 INFO - Writing to file /builds/slave/test/properties/build_url 20:51:03 INFO - Contents: 20:51:03 INFO - build_url:https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 20:51:04 INFO - Running post-action listener: _resource_record_post_action 20:51:04 INFO - Running post-action listener: set_extra_try_arguments 20:51:04 INFO - [mozharness: 2016-09-08 03:51:04.056561Z] Finished download-and-extract step (success) 20:51:04 INFO - [mozharness: 2016-09-08 03:51:04.056706Z] Running populate-webroot step. 20:51:04 INFO - Running pre-action listener: _resource_record_pre_action 20:51:04 INFO - Running main action method: populate_webroot 20:51:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:51:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:51:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:51:04 INFO - '--tppagecycles', 20:51:04 INFO - '7'], 20:51:04 INFO - 'tests': ['tsvgm']}}, 20:51:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:51:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:51:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:51:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:51:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:51:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:51:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['damp', 'tps']}, 20:51:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'tests': ['damp', 'tps']}, 20:51:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['dromaeo_dom']}, 20:51:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:51:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['basic_compositor_video']}, 20:51:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:51:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['a11yr', 20:51:04 INFO - 'ts_paint', 20:51:04 INFO - 'tpaint', 20:51:04 INFO - 'sessionrestore', 20:51:04 INFO - 'sessionrestore_no_auto_restore', 20:51:04 INFO - 'tabpaint']}, 20:51:04 INFO - 'other-e10s': {'tests': ['a11yr', 20:51:04 INFO - 'ts_paint', 20:51:04 INFO - 'tpaint', 20:51:04 INFO - 'sessionrestore', 20:51:04 INFO - 'sessionrestore_no_auto_restore', 20:51:04 INFO - 'tabpaint']}, 20:51:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:51:04 INFO - 'ts_paint', 20:51:04 INFO - 'tpaint', 20:51:04 INFO - 'sessionrestore', 20:51:04 INFO - 'sessionrestore_no_auto_restore', 20:51:04 INFO - 'tabpaint']}, 20:51:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:51:04 INFO - 'ts_paint', 20:51:04 INFO - 'tpaint', 20:51:04 INFO - 'sessionrestore', 20:51:04 INFO - 'sessionrestore_no_auto_restore', 20:51:04 INFO - 'tabpaint']}, 20:51:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['a11yr', 20:51:04 INFO - 'ts_paint', 20:51:04 INFO - 'tpaint', 20:51:04 INFO - 'sessionrestore', 20:51:04 INFO - 'sessionrestore_no_auto_restore', 20:51:04 INFO - 'tabpaint']}, 20:51:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['a11yr', 20:51:04 INFO - 'ts_paint', 20:51:04 INFO - 'tpaint', 20:51:04 INFO - 'sessionrestore', 20:51:04 INFO - 'sessionrestore_no_auto_restore', 20:51:04 INFO - 'tabpaint']}, 20:51:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['tsvgx', 20:51:04 INFO - 'tsvgr_opacity', 20:51:04 INFO - 'tart', 20:51:04 INFO - 'tscrollx', 20:51:04 INFO - 'cart']}, 20:51:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:51:04 INFO - 'tsvgr_opacity', 20:51:04 INFO - 'tart', 20:51:04 INFO - 'tscrollx', 20:51:04 INFO - 'cart']}, 20:51:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'talos_options': ['--disable-e10s'], 20:51:04 INFO - 'tests': ['tp5o']}, 20:51:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'tests': ['tp5o']}, 20:51:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'talos_options': ['--disable-e10s', 20:51:04 INFO - '--xperf_path', 20:51:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:51:04 INFO - 'tests': ['tp5n']}, 20:51:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:51:04 INFO - 'talos_options': ['--xperf_path', 20:51:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:51:04 INFO - 'tests': ['tp5n']}}, 20:51:04 INFO - 'talos.zip': {'path': '', 20:51:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:51:04 INFO - Running post-action listener: _resource_record_post_action 20:51:04 INFO - [mozharness: 2016-09-08 03:51:04.075806Z] Finished populate-webroot step (success) 20:51:04 INFO - [mozharness: 2016-09-08 03:51:04.075909Z] Running create-virtualenv step. 20:51:04 INFO - Running pre-action listener: _resource_record_pre_action 20:51:04 INFO - Running main action method: create_virtualenv 20:51:04 INFO - Creating virtualenv /builds/slave/test/build/venv 20:51:04 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 20:51:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:51:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:51:04 INFO - Using real prefix '/tools/python27' 20:51:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:51:04 INFO - Installing distribute.............................................................................................................................................................................................done. 20:51:07 INFO - Installing pip.................done. 20:51:07 INFO - Return code: 0 20:51:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:07 INFO - 'HOME': '/Users/cltbld', 20:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:07 INFO - 'LOGNAME': 'cltbld', 20:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:07 INFO - 'MOZ_NO_REMOTE': '1', 20:51:07 INFO - 'NO_EM_RESTART': '1', 20:51:07 INFO - 'PAGER': '/bin/cat', 20:51:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:07 INFO - 'PWD': '/builds/slave/test', 20:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:07 INFO - 'SHELL': '/bin/bash', 20:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:07 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:07 INFO - 'USER': 'cltbld', 20:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:07 INFO - 'XPC_FLAGS': '0x0', 20:51:07 INFO - 'XPC_SERVICE_NAME': '0', 20:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:08 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 20:51:08 INFO - Cleaning up... 20:51:08 INFO - Return code: 0 20:51:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:51:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:08 INFO - 'HOME': '/Users/cltbld', 20:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:08 INFO - 'LOGNAME': 'cltbld', 20:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:08 INFO - 'MOZ_NO_REMOTE': '1', 20:51:08 INFO - 'NO_EM_RESTART': '1', 20:51:08 INFO - 'PAGER': '/bin/cat', 20:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:08 INFO - 'PWD': '/builds/slave/test', 20:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:08 INFO - 'SHELL': '/bin/bash', 20:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:08 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:08 INFO - 'USER': 'cltbld', 20:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:08 INFO - 'XPC_FLAGS': '0x0', 20:51:08 INFO - 'XPC_SERVICE_NAME': '0', 20:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:08 INFO - Downloading/unpacking psutil>=3.1.1 20:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:51:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:51:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:51:11 INFO - Installing collected packages: psutil 20:51:11 INFO - Running setup.py install for psutil 20:51:11 INFO - building 'psutil._psutil_osx' extension 20:51:11 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 20:51:12 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 20:51:12 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 20:51:12 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 20:51:12 INFO - building 'psutil._psutil_posix' extension 20:51:12 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 20:51:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:51:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:51:12 INFO - ^ 20:51:12 INFO - 1 warning generated. 20:51:12 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 20:51:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:51:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:51:12 INFO - Successfully installed psutil 20:51:12 INFO - Cleaning up... 20:51:12 INFO - Return code: 0 20:51:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:12 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:12 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 20:51:12 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 20:51:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:12 INFO - 'HOME': '/Users/cltbld', 20:51:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:12 INFO - 'LOGNAME': 'cltbld', 20:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:12 INFO - 'MOZ_NO_REMOTE': '1', 20:51:12 INFO - 'NO_EM_RESTART': '1', 20:51:12 INFO - 'PAGER': '/bin/cat', 20:51:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:12 INFO - 'PWD': '/builds/slave/test', 20:51:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:12 INFO - 'SHELL': '/bin/bash', 20:51:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:12 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:12 INFO - 'USER': 'cltbld', 20:51:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:12 INFO - 'XPC_FLAGS': '0x0', 20:51:12 INFO - 'XPC_SERVICE_NAME': '0', 20:51:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:51: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 20:51: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 20:51: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 20:51: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 20:51: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 20:51: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 20:51:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:51:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:51:15 INFO - Installing collected packages: mozsystemmonitor 20:51:15 INFO - Running setup.py install for mozsystemmonitor 20:51:15 INFO - Successfully installed mozsystemmonitor 20:51:15 INFO - Cleaning up... 20:51:15 INFO - Return code: 0 20:51:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:51:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:15 INFO - 'HOME': '/Users/cltbld', 20:51:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:15 INFO - 'LOGNAME': 'cltbld', 20:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:15 INFO - 'MOZ_NO_REMOTE': '1', 20:51:15 INFO - 'NO_EM_RESTART': '1', 20:51:15 INFO - 'PAGER': '/bin/cat', 20:51:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:15 INFO - 'PWD': '/builds/slave/test', 20:51:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:15 INFO - 'SHELL': '/bin/bash', 20:51:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:15 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:15 INFO - 'USER': 'cltbld', 20:51:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:15 INFO - 'XPC_FLAGS': '0x0', 20:51:15 INFO - 'XPC_SERVICE_NAME': '0', 20:51:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:16 INFO - Downloading/unpacking jsonschema==2.5.1 20:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:51:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:18 INFO - Downloading functools32-3.2.3-2.tar.gz 20:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:51:19 INFO - warning: no files found matching '*.txt' 20:51:19 INFO - no previously-included directories found matching 'build' 20:51:19 INFO - no previously-included directories found matching 'dist' 20:51:19 INFO - no previously-included directories found matching '.git*' 20:51:19 INFO - Installing collected packages: jsonschema, functools32 20:51:19 INFO - Running setup.py install for functools32 20:51:19 INFO - warning: no files found matching '*.txt' 20:51:19 INFO - no previously-included directories found matching 'build' 20:51:19 INFO - no previously-included directories found matching 'dist' 20:51:19 INFO - no previously-included directories found matching '.git*' 20:51:19 INFO - Successfully installed jsonschema functools32 20:51:19 INFO - Cleaning up... 20:51:19 INFO - Return code: 0 20:51:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:51: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')]} 20:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:19 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:19 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 20:51:19 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 20:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:19 INFO - 'HOME': '/Users/cltbld', 20:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:19 INFO - 'LOGNAME': 'cltbld', 20:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:19 INFO - 'MOZ_NO_REMOTE': '1', 20:51:19 INFO - 'NO_EM_RESTART': '1', 20:51:19 INFO - 'PAGER': '/bin/cat', 20:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:19 INFO - 'PWD': '/builds/slave/test', 20:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:19 INFO - 'SHELL': '/bin/bash', 20:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:19 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:19 INFO - 'USER': 'cltbld', 20:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:19 INFO - 'XPC_FLAGS': '0x0', 20:51:19 INFO - 'XPC_SERVICE_NAME': '0', 20:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:51:19 INFO - Cleaning up... 20:51:19 INFO - Return code: 0 20:51:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:51: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')]} 20:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:19 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:19 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 20:51:19 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 20:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:19 INFO - 'HOME': '/Users/cltbld', 20:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:19 INFO - 'LOGNAME': 'cltbld', 20:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:19 INFO - 'MOZ_NO_REMOTE': '1', 20:51:19 INFO - 'NO_EM_RESTART': '1', 20:51:19 INFO - 'PAGER': '/bin/cat', 20:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:19 INFO - 'PWD': '/builds/slave/test', 20:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:19 INFO - 'SHELL': '/bin/bash', 20:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:19 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:19 INFO - 'USER': 'cltbld', 20:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:19 INFO - 'XPC_FLAGS': '0x0', 20:51:19 INFO - 'XPC_SERVICE_NAME': '0', 20:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:19 INFO - Downloading/unpacking blobuploader==1.2.4 20:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:51:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:51:22 INFO - Downloading blobuploader-1.2.4.tar.gz 20:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:51:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:51:22 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 20:51:22 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 20:51:22 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 20:51:22 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 20:51:22 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 20:51:22 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 20:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:51:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:51:23 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 20:51:23 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 20:51:23 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 20:51:23 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 20:51:23 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 20:51:23 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 20:51:23 INFO - Downloading docopt-0.6.1.tar.gz 20:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:51:23 INFO - Installing collected packages: blobuploader, requests, docopt 20:51:23 INFO - Running setup.py install for blobuploader 20:51:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:51:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:51:23 INFO - Running setup.py install for requests 20:51:24 INFO - Running setup.py install for docopt 20:51:24 INFO - Successfully installed blobuploader requests docopt 20:51:24 INFO - Cleaning up... 20:51:24 INFO - Return code: 0 20:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:51: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')]} 20:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51: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')]} 20:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:24 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:24 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 20:51:24 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 20:51:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:24 INFO - 'HOME': '/Users/cltbld', 20:51:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:24 INFO - 'LOGNAME': 'cltbld', 20:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:24 INFO - 'MOZ_NO_REMOTE': '1', 20:51:24 INFO - 'NO_EM_RESTART': '1', 20:51:24 INFO - 'PAGER': '/bin/cat', 20:51:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:24 INFO - 'PWD': '/builds/slave/test', 20:51:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:24 INFO - 'SHELL': '/bin/bash', 20:51:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:24 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:24 INFO - 'USER': 'cltbld', 20:51:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:24 INFO - 'XPC_FLAGS': '0x0', 20:51:24 INFO - 'XPC_SERVICE_NAME': '0', 20:51:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:51:24 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-STHC3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:51:24 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-S0k7z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-RDKz3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-WxMEnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-1CDNTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-ip31_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-RDOy2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-86UELt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-VuNioS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-C7r0UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-tV44Ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:51:25 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-Cw8oX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:51:26 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-iojdn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:51:26 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-qN_Ith-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:51:26 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-UKqXYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:51:26 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-2Y2dI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:51:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:51:26 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-apSTqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:51:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:51:26 INFO - Running setup.py install for manifestparser 20:51:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:51:26 INFO - Running setup.py install for mozcrash 20:51:26 INFO - Running setup.py install for mozdebug 20:51:27 INFO - Running setup.py install for mozdevice 20:51:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Running setup.py install for mozfile 20:51:27 INFO - Running setup.py install for mozhttpd 20:51:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Running setup.py install for mozinfo 20:51:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Running setup.py install for mozInstall 20:51:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:51:27 INFO - Running setup.py install for mozleak 20:51:27 INFO - Running setup.py install for mozlog 20:51:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:51:28 INFO - Running setup.py install for moznetwork 20:51:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:51:28 INFO - Running setup.py install for mozprocess 20:51:28 INFO - Running setup.py install for mozprofile 20:51:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:51:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:51:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:51:28 INFO - Running setup.py install for mozrunner 20:51:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:51:28 INFO - Running setup.py install for mozscreenshot 20:51:28 INFO - Running setup.py install for moztest 20:51:29 INFO - Running setup.py install for mozversion 20:51:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:51:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:51:29 INFO - Cleaning up... 20:51:29 INFO - Return code: 0 20:51:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:29 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:29 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 20:51:29 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 20:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:29 INFO - 'HOME': '/Users/cltbld', 20:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:29 INFO - 'LOGNAME': 'cltbld', 20:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:29 INFO - 'MOZ_NO_REMOTE': '1', 20:51:29 INFO - 'NO_EM_RESTART': '1', 20:51:29 INFO - 'PAGER': '/bin/cat', 20:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:29 INFO - 'PWD': '/builds/slave/test', 20:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:29 INFO - 'SHELL': '/bin/bash', 20:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:29 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:29 INFO - 'USER': 'cltbld', 20:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:29 INFO - 'XPC_FLAGS': '0x0', 20:51:29 INFO - 'XPC_SERVICE_NAME': '0', 20:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:51:29 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-Cri1IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:51:29 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)) 20:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:51:29 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-kB9wr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:51:29 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)) 20:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:51:29 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-GzyRcH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:51:29 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)) 20:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:51:29 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-p2jveZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:51:29 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)) 20:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:51:29 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-jx0PI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:51:29 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)) 20:51:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:51:29 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-QGJ0wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-MznCAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-cw_GRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-0gpHEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-jc7Xr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-fxWpUv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-s3WA3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-9wJdjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-lGPMAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:51:30 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)) 20:51:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:51:30 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-YHkcjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:51:31 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)) 20:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:51:31 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-rWyZO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:51:31 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)) 20:51:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:51:31 INFO - Running setup.py (path:/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/pip-2KhE8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:51:31 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)) 20:51:31 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)) 20:51:31 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)) 20:51:31 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)) 20:51:31 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)) 20:51:31 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)) 20:51:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:51:31 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 20:51:31 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 20:51:31 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 20:51:31 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 20:51:31 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 20:51:31 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 20:51:33 INFO - Downloading blessings-1.6.tar.gz 20:51:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:51:33 INFO - Installing collected packages: blessings 20:51:33 INFO - Running setup.py install for blessings 20:51:33 INFO - Successfully installed blessings 20:51:33 INFO - Cleaning up... 20:51:33 INFO - Return code: 0 20:51:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:51:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:51:34 INFO - Reading from file tmpfile_stdout 20:51:34 INFO - Current package versions: 20:51:34 INFO - blessings == 1.6 20:51:34 INFO - blobuploader == 1.2.4 20:51:34 INFO - docopt == 0.6.1 20:51:34 INFO - functools32 == 3.2.3-2 20:51:34 INFO - jsonschema == 2.5.1 20:51:34 INFO - manifestparser == 1.1 20:51:34 INFO - mozInstall == 1.12 20:51:34 INFO - mozcrash == 0.17 20:51:34 INFO - mozdebug == 0.1 20:51:34 INFO - mozdevice == 0.48 20:51:34 INFO - mozfile == 1.2 20:51:34 INFO - mozhttpd == 0.7 20:51:34 INFO - mozinfo == 0.9 20:51:34 INFO - mozleak == 0.1 20:51:34 INFO - mozlog == 3.3 20:51:34 INFO - moznetwork == 0.27 20:51:34 INFO - mozprocess == 0.23 20:51:34 INFO - mozprofile == 0.28 20:51:34 INFO - mozrunner == 6.12 20:51:34 INFO - mozscreenshot == 0.1 20:51:34 INFO - mozsystemmonitor == 0.3 20:51:34 INFO - moztest == 0.7 20:51:34 INFO - mozversion == 1.4 20:51:34 INFO - psutil == 3.1.1 20:51:34 INFO - requests == 1.2.3 20:51:34 INFO - wsgiref == 0.1.2 20:51:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:51:34 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')]} 20:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:34 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')]} 20:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:34 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:34 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 20:51:34 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 20:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:34 INFO - 'HOME': '/Users/cltbld', 20:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:34 INFO - 'LOGNAME': 'cltbld', 20:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:34 INFO - 'MOZ_NO_REMOTE': '1', 20:51:34 INFO - 'NO_EM_RESTART': '1', 20:51:34 INFO - 'PAGER': '/bin/cat', 20:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:34 INFO - 'PWD': '/builds/slave/test', 20:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:34 INFO - 'SHELL': '/bin/bash', 20:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:34 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:34 INFO - 'USER': 'cltbld', 20:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:34 INFO - 'XPC_FLAGS': '0x0', 20:51:34 INFO - 'XPC_SERVICE_NAME': '0', 20:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 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)) 20:51:34 INFO - Cleaning up... 20:51:34 INFO - Return code: 0 20:51:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:51:34 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')]} 20:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:34 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')]} 20:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:51:34 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 0x10e1bfa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e254618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa710558ff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, '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.MQORKFtbAb/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.atbrQeBWxR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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 20:51:34 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 20:51:34 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 20:51:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:51:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:51:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:51:34 INFO - 'HOME': '/Users/cltbld', 20:51:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:51:34 INFO - 'LOGNAME': 'cltbld', 20:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:51:34 INFO - 'MOZ_NO_REMOTE': '1', 20:51:34 INFO - 'NO_EM_RESTART': '1', 20:51:34 INFO - 'PAGER': '/bin/cat', 20:51:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:51:34 INFO - 'PWD': '/builds/slave/test', 20:51:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:51:34 INFO - 'SHELL': '/bin/bash', 20:51:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:51:34 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:51:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:51:34 INFO - 'USER': 'cltbld', 20:51:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:51:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:51:34 INFO - 'XPC_FLAGS': '0x0', 20:51:34 INFO - 'XPC_SERVICE_NAME': '0', 20:51:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:51:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:51:34 INFO - Cleaning up... 20:51:34 INFO - Return code: 0 20:51:34 INFO - Running post-action listener: _resource_record_post_action 20:51:34 INFO - Running post-action listener: _start_resource_monitoring 20:51:34 INFO - Starting resource monitoring. 20:51:34 INFO - [mozharness: 2016-09-08 03:51:34.820403Z] Finished create-virtualenv step (success) 20:51:34 INFO - [mozharness: 2016-09-08 03:51:34.821230Z] Running install step. 20:51:34 INFO - Running pre-action listener: _resource_record_pre_action 20:51:34 INFO - Running main action method: install 20:51:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:51:35 INFO - Reading from file tmpfile_stdout 20:51:35 INFO - Detecting whether we're running mozinstall >=1.0... 20:51:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:51:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:51:35 INFO - Reading from file tmpfile_stdout 20:51:35 INFO - Output received: 20:51:35 INFO - Usage: mozinstall [options] installer 20:51:35 INFO - Options: 20:51:35 INFO - -h, --help show this help message and exit 20:51:35 INFO - -d DEST, --destination=DEST 20:51:35 INFO - Directory to install application into. [default: 20:51:35 INFO - "/builds/slave/test"] 20:51:35 INFO - --app=APP Application being installed. [default: firefox] 20:51:35 INFO - mkdir: /builds/slave/test/build/application 20:51:35 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'] 20:51:35 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 20:52:09 INFO - Reading from file tmpfile_stdout 20:52:09 INFO - Output received: 20:52:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:52:09 INFO - Running post-action listener: _resource_record_post_action 20:52:09 INFO - [mozharness: 2016-09-08 03:52:09.597532Z] Finished install step (success) 20:52:09 INFO - [mozharness: 2016-09-08 03:52:09.597667Z] Running run-tests step. 20:52:09 INFO - Running pre-action listener: _resource_record_pre_action 20:52:09 INFO - Running main action method: run_tests 20:52:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:52:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:52:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:52:09 INFO - 2016-09-07 20:52:09.612 screenresolution[1637:7402] starting screenresolution argv=screenresolution get 20:52:09 INFO - 2016-09-07 20:52:09.615 screenresolution[1637:7402] Display 0: 1600x1200x32@60 20:52:09 INFO - 2016-09-07 20:52:09.620 screenresolution[1638:7405] starting screenresolution argv=screenresolution list 20:52:09 INFO - Available Modes on Display 0 20:52:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:52:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:52:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:52:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:52:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:52:09 INFO - Intel Iris: 20:52:09 INFO - Chipset Model: Intel Iris 20:52:09 INFO - Type: GPU 20:52:09 INFO - Bus: Built-In 20:52:09 INFO - VRAM (Dynamic, Max): 1536 MB 20:52:09 INFO - Vendor: Intel (0x8086) 20:52:09 INFO - Device ID: 0x0a2e 20:52:09 INFO - Revision ID: 0x0009 20:52:09 INFO - Displays: 20:52:09 INFO - Display: 20:52:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:52:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:52:09 INFO - Display Serial Number: 1600x1200 60 20:52:09 INFO - Main Display: Yes 20:52:09 INFO - Mirror: Off 20:52:09 INFO - Online: Yes 20:52:09 INFO - Rotation: Supported 20:52:09 INFO - Return code: 0 20:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:52:09 INFO - Python 2.7.3 20:52:09 INFO - Return code: 0 20:52:09 INFO - grabbing minidump binary from tooltool 20:52: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')]} 20:52:09 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 0x10e123d30>, '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 0x10de88db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e11bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:52:09 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 20:52:09 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 20:52:09 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 20:52:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:52:09 INFO - Return code: 0 20:52:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:52:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:52:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:52:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:52:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:52:09 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/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 20:52:09 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/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0018 --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 20:52:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MQORKFtbAb/Render', 20:52:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:52:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:52:09 INFO - 'HOME': '/Users/cltbld', 20:52:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:52:09 INFO - 'LOGNAME': 'cltbld', 20:52:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:52:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:52:09 INFO - 'MOZ_NO_REMOTE': '1', 20:52:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:52:09 INFO - 'NO_EM_RESTART': '1', 20:52:09 INFO - 'PAGER': '/bin/cat', 20:52:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:52:09 INFO - 'PWD': '/builds/slave/test', 20:52:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:52:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:52:09 INFO - 'SHELL': '/bin/bash', 20:52:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.atbrQeBWxR/Listeners', 20:52:09 INFO - 'TMPDIR': '/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/', 20:52:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:52:09 INFO - 'USER': 'cltbld', 20:52:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:52:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:52:09 INFO - 'XPC_FLAGS': '0x0', 20:52:09 INFO - 'XPC_SERVICE_NAME': '0', 20:52:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:52:09 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/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0018', '--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 20:52:10 INFO - mozversion application_buildid: 20160907180916 20:52:10 INFO - mozversion application_changeset: fb7c6b0343295392bac590c19b14e7e5dcccdc33 20:52:10 INFO - mozversion application_display_name: Nightly 20:52:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:52:10 INFO - mozversion application_name: Firefox 20:52:10 INFO - mozversion application_remotingname: firefox 20:52:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:52:10 INFO - mozversion application_vendor: Mozilla 20:52:10 INFO - mozversion application_version: 51.0a1 20:52:10 INFO - mozversion platform_buildid: 20160907180916 20:52:10 INFO - mozversion platform_changeset: fb7c6b0343295392bac590c19b14e7e5dcccdc33 20:52:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:52:10 INFO - mozversion platform_version: 51.0a1 20:52:10 INFO - using testdate: 1473306730 20:52:10 INFO - actual date: 1473306730 20:52:10 INFO - starting webserver on 'localhost:49272' 20:52:10 INFO - SUITE-START | Running 2 tests 20:52:10 INFO - TEST-START | dromaeo_css 20:52:10 INFO - operating with platform_type : mac_ 20:52:10 INFO - Initialising browser for dromaeo_css test... 20:52:10 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpZ8AKfN/profile http://localhost:49272/getInfo.html) 20:52:12 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 20:52:12 INFO - PROCESS | 1648 | colorDepth:24 20:52:12 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 20:52:12 INFO - PROCESS | 1648 | __metrics 20:52:13 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 20:52:13 INFO - TEST-INFO | 1648: exit 0 20:52:13 INFO - Browser initialized. 20:52:13 INFO - Running cycle 1/1 for dromaeo_css test... 20:52:13 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpZ8AKfN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:52:25 INFO - PROCESS | 1651 | RSS: Main: 243527680 20:52:25 INFO - PROCESS | 1651 | 20:53:15 INFO - PROCESS | 1651 | 1473306795248 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] 20:55:27 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 20:55:28 INFO - PROCESS | 1651 | RSS: Main: 264056832 20:55:28 INFO - PROCESS | 1651 | 20:58:31 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 20:58:31 INFO - PROCESS | 1651 | RSS: Main: 269307904 20:58:31 INFO - PROCESS | 1651 | 21:01:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 21:01:34 INFO - PROCESS | 1651 | RSS: Main: 275345408 21:01:34 INFO - PROCESS | 1651 | 21:04:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 21:04:36 INFO - PROCESS | 1651 | RSS: Main: 271474688 21:04:36 INFO - PROCESS | 1651 | 21:07:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 21:07:40 INFO - PROCESS | 1651 | RSS: Main: 276799488 21:07:40 INFO - PROCESS | 1651 | 21:10:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 21:10:43 INFO - PROCESS | 1651 | RSS: Main: 279719936 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | __start_tp_report 21:10:43 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 21:10:43 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 21:10:43 INFO - PROCESS | 1651 | |i|pagename|runs| 21:10:43 INFO - PROCESS | 1651 | |0;dojo.html;2778.5137600919834;2797.978737760717;2857.314244581301;3390.898273051808;3433.227523807144;5341.332333458317;5720.570957178218;5813.738381772825;5857.794977175799;5901.734421951017;5725.912076705423;5781;5852.561057920651;5861.7948371807;5879.911801322984;5189.766460509267;5277.498637629419;5310.867228319304;5381.704006279653;5387.1111266640955;5359.356877174744;5359.624826262144;5385.865353366177;5432.972835135819;5452.727363631822;5159.613029022819;5201.687898726089;5254.7635356409055;5291.126964050927;5302.575793936476;5243;5243.9213411798855;5275.103232450492;5324.0150572144275;5348.197770334481;5303.549198318147;5310.8141215057285;5323.840284791462;5349.545288650469;5357.303550538444;5331.360236771573;5689.9146512802345;5872.911906321408;5878.823635290948;5893.233879595668;6169;6176.073588961647;6246.906296405557;6250.0624906263965;6262.060690896356;5193.558547523465;6120.721420533214;6221.502279817649;6281.24625044993;6316.084167795644;5952.672603006833;5970.880582388415;5992.131140984533;6016.488598469092;6050.183225264577;6116.602420842631;6311.737652469433;6402.807915762534;6448.903266451007;6471.5146364022885;5703.942960570341;6074.271087469532;6120.447133218794;6230;6263.404976527223;6123.540734444934;6176.042713379434;6197.349278325801;6250.968745156336;6265.592736472115;6139.57023008394;6145.600535965148;6223.906641400383;6230.158928544679;6239.875202495925;4960.305557221992;6136.693165341715;6252.624842509464;6252.749890004349;6281.528885333618;4917.803287868517;4971.055499455164;4982.501749824988;4988.251762235694;5005.1491246488185;4440.111977604492;4442.644588432918;4451.621612162938;4460.130274596422;4470.2177119004045;5894.233749612523;6008.819735407945;6026.728797204137;6053.364396738367;6054.576179667381;6138.817583427401;6170.197874276315;6194.566380353423;6215.875682486325;6261.624302541771;5974.133750606138;5974.40255974399;5985.371535988746;6006.249218847644;6031.185789918305;5480.890382192334;5492.340919089735;5529.225908372831;5538;5541.861453463615;6312.4634406076;6423.518236132402;6432.6140431572385;6439.710213040518;6446.774362897276;6238.719257633326;6258.092576576462;6279.277883043508;6283.340249273943;6286.371362863677;6441;6471.676416179266;6521.380468855451;6522.934770652422;6527.836804079936;6127.0062805303205;6150.769846030722;6160.815175544741;6202.224721909762;6213.347598502273;4987.750612469435;6176.104464852661;6192.195014648247;6226.5641405101205;6231.563790534619;5218.869528261824;5635.7601327707835;6012.308584512837;6219.346968568235;6240.251169859646;5594.944050559442;5677.432256774289;6105.247473116839;6107.795737660903;6143.0206349921145;4732.455767586634;4936.889199929987;5725.312962444534;6002.429769171922;6130.785422510191;6108.602940808833;6176.7838125665385;6189;6191.1641928339095;6302.1492098566105;5990.161377407079;6041.124037014696;6041.728122234422;6079.878402431838;6130.50955923534 21:10:43 INFO - PROCESS | 1651 | |1;ext.html;479.58036717871863;485.589676723169;536.011059595047;545.345585297643;563.9887202255952;31930.201744956386;34357.96926092218;37519.81240093795;39791.403128953054;39812.203755924864;40955.59044409555;41449.79275103628;41461.792691036506;41520.79239603805;41529.58470415295;9538.141567258945;9629.518524073768;9735.610575576968;9737.1236588707;9769.560369783341;9498.667546635868;9535.80928381432;9579.0420957904;9590.42457452555;9612.711618651452;9495.667651632195;9587.856182157273;9606.423614583113;9634.036596340346;9636.132748052674;9500.192483638864;9518.476483793389;9572.042795720441;9584.329096963216;9596.136347728738;9576.186024187953;9628.66299679508;9662.613495460173;9667.178289845371;9668.419894806264;39208;39458.60541394578;39479.40780888289;39627;39725.20549589021;3191.5531825544444;3204.6314673812576;3211.807291562514;3267.9019629411155;3287.917802054944;30235.395292094254;30520.38959220803;30608.693913060808;30680.53979190314;31801.681983180104;3198.296374797541;3231.2568109334748;3236.45151525678;3288.588926384202;3340.2985373071683;453849;455907.72046139557;456944;457627;459484;56683.716581416826;56722;56904.43095568991;56916.71541642265;57063.85872282614;31031.534526982112;33708.48311825973;35321.29357412837;36269;59009.704951475826;16073.437429689904;16213.432529861399;16221.513354599381;16233.51299461018;16240.918795405947;11943.88056119445;12437.129400941847;12553.811692824615;12559.058070644738;12572.685682858002;18175.545611359823;18355;18541;18623.627527449375;18651.81348186528;7735.259566597583;7855.72504962335;7870.645820938072;7889.303799683095;7969.282764551102;855.5209082913589;941.9481928493861;955.7180631713522;1021.8313978193515;1095.6603452929617;29503.55744663832;30619.234519136753;31168.909088181805;31828;32549.18627034343;780.9804754881173;978.2125389061731;999.860019597257;1013.2704452793977;1040.351043595909;14428;14830.88768342357;14931.402743890123;15081.321340539702;15275.694486110215;510928;611355;616607;617865;618252;47893.28160077602;53446;53812.390017597;54087.18869216965;54531.72734136304;1271.211848653822;1329.8869596084442;1330.3215360166191;1330.733853229358;1340.8592097829783;27448.17655470339;28497.857510712314;28635.28411789722;28949.276268092624;28988.710112899444;39411.802940985115;40827.1834563313;47733;48495.75752121217;50682.732931677005;391426;410779.3830925385;453675;474615;474649.2535074743;25174.867130979517;25431.87284063568;25543.744562554137;25646.87176564105;25882.741172588034;33148.171295716835;41258.968525787095;42085.78957105195;42768.57231427646;42918.78540607277;36601.63398366089;36897.63102368942;37452.812735936146;37702.811485942395;37885.62114378821;36597.451038233914;36984.445233320985;37523.81238093792;37731.81134094312;37755.62244377631;35836;35883;36758.63241367552;36769.816150919076;36914.07714807151;32141;33010.30763720343;33169;33262.833685831414;33416.832915835264;22074.44813879666;22423.09273448616;24761.133360332304;25030;25392.984280628567 21:10:43 INFO - PROCESS | 1651 | |2;jquery.html;317.5348115011508;337.87667501362;348.9616142224355;349.577011815703;373.47153777404975;15469;18188.545286367815;19116.235350585994;20270.89864550677;20560.588788224228;19582.70625940612;20583.691244631344;20690.68963965542;20733.792662073374;20884.89557552214;5616.0171969905105;5850.970745146279;6140.723667434954;6171.969140154293;6173.413525715072;5440.510354068133;6057.424544668272;6104.633721976674;6144.109104179891;6165;5691.406406206269;6094.451499365056;6125.663088530151;6144.5084393248435;6159.26088869334;5381.757820898049;6129.0499972503885;6145.508359331243;6178.876422471548;6186.536009799261;5133.871653208662;5466.480684334982;5521.420250873641;5817.7382017809305;5998;10939.507722152523;12858.742825143538;12996;13040.934795326057;24267.150649727173;2290.5075408787025;2312.90748370065;2500.987495062513;2817.8591070446396;2892.2335581071034;7214.819629509252;10104.191664666809;10262.127719143882;13631.318434078355;13845.446182152702;1842.5946291815778;1862.1341076399403;1863.236073209991;1893.943181704551;1907.3038341005572;110432.4478377611;119193.61612767783;123731.76268237382;126408.10387844189;127813.72186278111;9397.483138427453;10502.422366769748;11483.301424165315;11555.826662600068;11902.880971190178;14246;14460.927695361455;14463;14471.204083775494;14498.202598856953;7637.8161384985415;8242.711505097413;8468.026176989602;8495.660173592987;8566;8202;8364.749057528285;8433.578321083922;8486.448380855225;8554.01628812682;3809.3333666608232;4445.488768791631;4532.320151977164;4546.999660074778;4616.722996620147;1569.8194707608543;1945.9902700486407;1948.6395016921915;1954.6383918975034;1960.7156962240394;791.8693415586479;858.8153546987303;871.4248595926658;879.8856148700628;924.9917589827121;20866;21700.782992170192;21735;21857.890710546344;22007.449813754785;909.5770466733001;930.2000279759402;934.3926447808979;945.8581212818133;988.5255077562666;10556.832950114935;11321.319971839062;11347.921947415147;11379.487923043484;11493.080553555696;484486;603014;609911;611179;616640;147115;154000.45999539862;155415.22292388466;155762;159713;995.0546681238162;1003.799240151958;1023.5138309303021;1028.6554004408606;1042.2183362478142;19707;19860.70208946838;20073.598528029066;20128;20152;57200.141997870895;58134.418655814596;59462.513437164416;59474;59898.70050649719;88186.55906720426;88200;88718.55640721755;89615;90932;5038.823641172688;7018.2630823762765;7678.963339949036;7913.366930645419;8294.212049855254;9933.503324833584;12767.233965962072;12987.35063246815;13339;13413.262270574822;8872;10777.08394786452;11025.007749302602;11058.668239952814;11382.601608943647;9176.44941303524;10732.356058636507;10783.946080269548;11241.60654377093;11249.71875703114;11010.174236932102;11301.660950171508;11435.371054592077;11473.196876218584;11512.36681982499;7117.110361204849;7298.817529561803;7497.850042999218;7501.962490187514;7668.424868135024;9210.677626283048;10997.471788248258;11060.502277397376;11165.609203677832;11233.66299011031 21:10:43 INFO - PROCESS | 1651 | |3;mootools.html;1488.1443170177151;1520.2702702702702;1697.176869218429;1811.1216060210788;1837.8070302618232;8001.519908805476;8420.368472364567;8619.569021548929;8954.3284253681;8966.596503157365;8585.527795971218;8679.47923124613;8790.780230494242;8802.383833131684;8818.20636142747;2354.0819080558554;2401.6757737705448;2402.8077753779658;2409.77107174819;2410.915617953372;2361.268006917861;2383.5947888858936;2393.9521209575796;2400.3399065257017;2407.9157229496973;2220.4448887778058;2226.7661895500983;2242.876641784709;2243.8317126215516;2246.382244882654;2312.4103353644714;2343.0627748900406;2373.0982226753895;2373.774491423312;2389.7012873390913;2339.4385347516645;2375.8099352051795;2379.179183181817;2385.022140922231;2393.1674918968392;8710.998235202906;8806.383553151281;8827.337949653802;8846.02693703692;8864;4323.589259020388;5365.597580181463;5384;5388.757505912244;5392.757325920343;3689.1330537323706;3703.2593481303848;3734.0851491384515;3760.417135344026;3769.566499852497;1095.8520599719016;1096.4298564746366;1097.6542389147394;1097.8033943002165;1113.8551988241559;11354.886451135548;11474.770504589862;11608.883911160865;11618.360990145455;11651.59219427316;4160.916781664349;4470.955290447119;4731.668783185144;4832.371791667061;4850.054239423279;9798.167155791694;9831.213502919749;9832.508374581243;9896.208303335716;9901.653442129491;5279.234510995961;5336.67979921206;5345.4498195522865;5362.302900622894;5364.30264065669;4068.7762173080173;4434.667399945017;4743.6916600421555;4876.780544875489;4903.141950158779;3855.691544676419;3930.1157239620857;3972.920541589152;4005.3991901214467;4045.332520134145;1300.3563236198142;1312.1536608887213;1314.8750868667462;1327.2169420042221;1329.5878277733934;803.4897839871724;838.2162677896187;883.1654086887829;894.9731508054768;897.9640814367483;4538.659600529973;4858.8299409521205;5719.628224165416;5742.655440673573;5864.941350586525;675.4326365852708;770.3375097416217;786.9724559640385;808.3210103513077;900.684760333891;3406.7615266931075;3861.4593956846065;3929.9214015719526;3933.7246392752804;3992.6007399260425;10260.692179234635;10301.742456438498;10588.523516441624;10656.573737050587;10694.465276736131;10563.788724225473;10585.576576936835;10628.893711062945;10632.096271816983;10677.786444271227;8038;8108.391870609727;8245;8294;8356.791080222922;5758.481736643722;5758.740856661377;5818.33089194748;5849.151872978479;5857.882842343044;9955.950220248853;9977.700668979942;10047.748806279902;10057.949710251401;10118;9759.853602195832;10254.743631409274;10283.897161028293;10287.948560257151;10335.431551264752;6493.707783149864;6508.642024688687;6547.639879806657;6942.826429339307;7092.6099064551945;8388.748337549883;8446.619902104543;8462.069172391155;8470.15298470148;8497.235248827636;7406.370458511087;7524.360429363565;7524.736634217776;7529.209433009455;7639.312461878235;7331.743388981574;7366.189719130784;7381.483296169216;7508;7531.096268447822;5863.794767183128;7034.366906978396;7037.542559733601;7051.753188638373;7054.8712206046785;4628.722276663411;4904.653768729502;4965.354503914468;5042.168042272984;5048.293238946477;4617.191991401559;4638.026014536985;4959.851204463872;5151.974240128776;5173.844784656466 21:10:43 INFO - PROCESS | 1651 | |4;prototype.html;284.30062047363486;293.82664228105415;309.19300625367794;312.9108204161814;316.52205170193;5398.325209348832;5544.390117087117;5679.671334752752;5683.5169010634045;5700.287464066992;5003.39959204895;5176.637635365526;5233.822389962256;5616.213730077792;5743.712814359286;3399.7702182926196;3439.914002149941;3657.3599620066516;3803.7717736935733;4130.628243458088;3533.6643018913164;3818.9427158592644;4343.109662519176;4352.107817897323;4361.60745532902;3610.7472476926628;3856.9614303856883;4164.043529094347;4180.038591124028;4217.514985776645;4142.005918579519;4181.790910454481;4183.539810620845;4239.448871646666;4247.405363249148;3011.891675826908;3442.1050526863196;3624.0939765058733;3641.1261297288725;3667.4865518827387;5129.512696293883;5179.860430705239;5370.979513892348;5483.150111732688;5544.445555444423;3882.9611703882883;4334.875910803715;4515.706479078882;4793.9280910786365;4889.828855990058;4336.720667403124;5488.53347465462;5940;5961;5990.490808281302;3470.8091054991964;3642.9817850910576;3869.303525365433;3941.4087886817206;3972.443857859902;5206.505381988705;5232.424433312332;5800.680962547058;6272.247330320391;6298.181236439279;3257;3394.9660503395144;4034.3948407738485;4049.2913740095364;4061.862678450039;3307.371599396107;3713.9600911744756;3825.2349530094093;4052.2300762855552;4061.248668996245;4102.50769907613;4808.89395439051;4840.249761287007;4845.515448455197;4887.315775791392;5722.227499287626;6001.339852616209;6027.698615069229;6136.2636483622255;6174.413430724074;1253.4672764075415;1305.719270356859;1335.626024713082;1383.2392184298596;1397.7134687389062;743.4981387563373;913.9040400757825;931.7996630724291;934.7382732834681;938.7043081429327;4445.688521886052;5263.6840789802545;5336.573074154058;5474.671519708831;5664.867026594698;6164.291106522717;6196.791625633048;6197.343567295317;6198.81403557894;6242.406971337807;4368.584984426474;4718.669693121448;5113.411957624847;5348.064088784447;5580.469855363734;2841.5453527435925;3175.5712978747574;3252.4796032634663;3275.836208189581;3289.490129030004;5150.613703972217;5782.761653473984;6364.363563643691;6497.480201583862;6508.642024688687;4835.419749630067;5726.455986681259;6124.6325220486915;6425.293217746044;6450.580712253689;5403.432639572867;6521.510886683518;6539.378759017885;6596.208454985336;6624.801255962136;5727.398623144676;6002.612412919583;6041.728122234422;6180.567360284737;6235.657038862906;6055.2430946131735;6096.75612975476;6119.033941906606;6176.722047507783;6189.319174890668;6147.938520614736;6389;6514.654724299343;6562.77030303937;6654.236627293868;3379.9155021123684;3560.946585801267;3571.2500374921556;3738.7195960302543;4052.0072582217545;5853.473187413153;6165.599236049642;6273.765208484346;6279.434850863444;6297.173819592267;4712.575868171881;4841.95158048415;4911.852644420673;5199.896002080013;5956.493698035715;5849.420656422827;6009.308929473166;6092.360302168208;6103.443621876393;6141.3551577085545;4910.165271903714;5475.753591088331;5543.445655434424;5601.795613943022;5728.971355143198;4830.033993201304;4937.703737775745;5661.915071273852;5782.7686892523825;5986.55100867428;5101.311322971352;5397.298351214474;5637;5825.155352473783;5881.588288819741 21:10:43 INFO - PROCESS | 1651 | |5;yui.html;685.4276678973057;706.3960313931589;723.3706675192583;763.736510903738;814.9511029338238;15020.624484387881;15746.685066298667;15763.290651920663;15786.842131578695;15814.525564233063;13184.670383240424;13529;13570.185788852652;13787.310634468262;13943.790843137362;842.3177226446583;843.173689784012;853.9402241843073;855.2815634866711;860.1699360117485;675.3246753246754;853.0829358439671;854.0733304364771;856.25933567464;858.8239410920778;704.8555046215539;852.9445586036919;872.9083446238149;899.6806133822497;900.0954041188596;873.3013589128703;889.0353965946923;890.1810334492251;890.8975467821153;890.9955450222773;657.641585335993;660.7125900233414;662.7249691378072;666.247140730971;669.4042302350912;14719.852801471956;14981.625459363495;15038.924805376013;15062.171580563065;15068.472603458937;11218.214724969255;11251.887481125166;13603.523876664269;13856.237906915116;13878.93060534701;10512.316699414514;12403.689907752288;12506.249625022438;12578.496860125584;12666;4464.933026004613;4468.2850743881145;4513.661475389359;4521.977390113061;4635.95364046362;120011;124838.37580812039;125207.74792252052;126075.3696231513;126938;10788.838167427495;10817.080548153337;10856.131509479223;10881.455927203608;10915.781684366268;20693;20885.79114208869;21322.14711411526;21340.893295533733;21387.358379248646;7628.427867909929;7705.095627255903;7781.494202876908;7890.921090789134;7919.643616037292;4354.042110735633;4480.798364073559;4486.6186374157905;4582.725036497821;4589.173948689268;3385.8476368563474;3419.504171895111;3487.9302413952087;3488.8081155536183;3518.7888726676483;626.2766504687003;629.471244154912;647.0165348669996;664.8936170212743;675.4596322941725;532.7496076843877;558.3634656491603;588.8204097750228;598.7814796888398;600.4115966352998;8728;8733.694320698745;8841.204291613785;8894.911050889537;9142.085791420805;534.8689571055116;564.7599770097692;584.3017593975159;591.7632946821305;607.8936186167404;3645.5989841117457;4322.330038843984;4358.106588149421;4427.977860110679;4466.129104824593;85360;100798.4960075195;141644.5835541652;154813;161546;131254;139662;140884;142288;143332;67203;89292;101379.46551336275;107948;111711.44144279226;8285.171482851907;8398.958005209935;8450.408471406943;8569.143085691381;8629.956850215709;65677.24104902495;65776;66515.33711657053;66616;66680.33319666742;78313;85409;93348.13303734023;101222.46943826463;103916.48041759743;10899.509522071367;11179.496922638664;11496.827547586625;11539.423028848692;11797.52809887595;11293.265937714023;11302;11878.524859005889;12056.336901470153;12237.75524489523;11125.944370278097;11490.88509114898;11651.650450486499;12051.57819476314;12053.156279060382;9466.384684995728;10322.948385258025;11038.227324087236;11087.667369978913;11355.261907975955;11272.943635281772;11533.653990380302;11560.826587601025;11669.474873630877;11926.582569610022;9361.4383137012;9518.571664275263;9681.903180968382;9691.127798497888;9982.051705088004;8262.917370826455;8492.282469609665;9633.08485693858;9797.71433122269;9854.211663066793 21:10:43 INFO - PROCESS | 1651 | __end_tp_report 21:10:43 INFO - PROCESS | 1651 | __start_cc_report 21:10:43 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,381 21:10:43 INFO - PROCESS | 1651 | __end_cc_report 21:10:43 INFO - PROCESS | 1651 | __startTimestamp1473307843139__endTimestamp 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | ------- Summary: start ------- 21:10:43 INFO - PROCESS | 1651 | Number of tests: 6 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5755.86 Median:6012.31 stddev:688.80 (11.5%) stddev-sans-first:650.11 21:10:43 INFO - PROCESS | 1651 | Values: 2778.5 2798.0 2857.3 3390.9 3433.2 5341.3 5720.6 5813.7 5857.8 5901.7 5725.9 5781.0 5852.6 5861.8 5879.9 5189.8 5277.5 5310.9 5381.7 5387.1 5359.4 5359.6 5385.9 5433.0 5452.7 5159.6 5201.7 5254.8 5291.1 5302.6 5243.0 5243.9 5275.1 5324.0 5348.2 5303.5 5310.8 5323.8 5349.5 5357.3 5331.4 5689.9 5872.9 5878.8 5893.2 6169.0 6176.1 6246.9 6250.1 6262.1 5193.6 6120.7 6221.5 6281.2 6316.1 5952.7 5970.9 5992.1 6016.5 6050.2 6116.6 6311.7 6402.8 6448.9 6471.5 5703.9 6074.3 6120.4 6230.0 6263.4 6123.5 6176.0 6197.3 6251.0 6265.6 6139.6 6145.6 6223.9 6230.2 6239.9 4960.3 6136.7 6252.6 6252.7 6281.5 4917.8 4971.1 4982.5 4988.3 5005.1 4440.1 4442.6 4451.6 4460.1 4470.2 5894.2 6008.8 6026.7 6053.4 6054.6 6138.8 6170.2 6194.6 6215.9 6261.6 5974.1 5974.4 5985.4 6006.2 6031.2 5480.9 5492.3 5529.2 5538.0 5541.9 6312.5 6423.5 6432.6 6439.7 6446.8 6238.7 6258.1 6279.3 6283.3 6286.4 6441.0 6471.7 6521.4 6522.9 6527.8 6127.0 6150.8 6160.8 6202.2 6213.3 4987.8 6176.1 6192.2 6226.6 6231.6 5218.9 5635.8 6012.3 6219.3 6240.3 5594.9 5677.4 6105.2 6107.8 6143.0 4732.5 4936.9 5725.3 6002.4 6130.8 6108.6 6176.8 6189.0 6191.2 6302.1 5990.2 6041.1 6041.7 6079.9 6130.5 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:62694.42 Median:37820.62 stddev:134257.52 (355.0%) stddev-sans-first:134552.89 21:10:43 INFO - PROCESS | 1651 | Values: 479.6 485.6 536.0 545.3 564.0 31930.2 34358.0 37519.8 39791.4 39812.2 40955.6 41449.8 41461.8 41520.8 41529.6 9538.1 9629.5 9735.6 9737.1 9769.6 9498.7 9535.8 9579.0 9590.4 9612.7 9495.7 9587.9 9606.4 9634.0 9636.1 9500.2 9518.5 9572.0 9584.3 9596.1 9576.2 9628.7 9662.6 9667.2 9668.4 39208.0 39458.6 39479.4 39627.0 39725.2 3191.6 3204.6 3211.8 3267.9 3287.9 30235.4 30520.4 30608.7 30680.5 31801.7 3198.3 3231.3 3236.5 3288.6 3340.3 453849.0 455907.7 456944.0 457627.0 459484.0 56683.7 56722.0 56904.4 56916.7 57063.9 31031.5 33708.5 35321.3 36269.0 59009.7 16073.4 16213.4 16221.5 16233.5 16240.9 11943.9 12437.1 12553.8 12559.1 12572.7 18175.5 18355.0 18541.0 18623.6 18651.8 7735.3 7855.7 7870.6 7889.3 7969.3 855.5 941.9 955.7 1021.8 1095.7 29503.6 30619.2 31168.9 31828.0 32549.2 781.0 978.2 999.9 1013.3 1040.4 14428.0 14830.9 14931.4 15081.3 15275.7 510928.0 611355.0 616607.0 617865.0 618252.0 47893.3 53446.0 53812.4 54087.2 54531.7 1271.2 1329.9 1330.3 1330.7 1340.9 27448.2 28497.9 28635.3 28949.3 28988.7 39411.8 40827.2 47733.0 48495.8 50682.7 391426.0 410779.4 453675.0 474615.0 474649.3 25174.9 25431.9 25543.7 25646.9 25882.7 33148.2 41259.0 42085.8 42768.6 42918.8 36601.6 36897.6 37452.8 37702.8 37885.6 36597.5 36984.4 37523.8 37731.8 37755.6 35836.0 35883.0 36758.6 36769.8 36914.1 32141.0 33010.3 33169.0 33262.8 33416.8 22074.4 22423.1 24761.1 25030.0 25393.0 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:35633.76 Median:2659.42 stddev:99262.60 (3732.5%) stddev-sans-first:99505.64 21:10:43 INFO - PROCESS | 1651 | Values: 317.5 337.9 349.0 349.6 373.5 15469.0 18188.5 19116.2 20270.9 20560.6 19582.7 20583.7 20690.7 20733.8 20884.9 5616.0 5851.0 6140.7 6172.0 6173.4 5440.5 6057.4 6104.6 6144.1 6165.0 5691.4 6094.5 6125.7 6144.5 6159.3 5381.8 6129.0 6145.5 6178.9 6186.5 5133.9 5466.5 5521.4 5817.7 5998.0 10939.5 12858.7 12996.0 13040.9 24267.2 2290.5 2312.9 2501.0 2817.9 2892.2 7214.8 10104.2 10262.1 13631.3 13845.4 1842.6 1862.1 1863.2 1893.9 1907.3 110432.4 119193.6 123731.8 126408.1 127813.7 9397.5 10502.4 11483.3 11555.8 11902.9 14246.0 14460.9 14463.0 14471.2 14498.2 7637.8 8242.7 8468.0 8495.7 8566.0 8202.0 8364.7 8433.6 8486.4 8554.0 3809.3 4445.5 4532.3 4547.0 4616.7 1569.8 1946.0 1948.6 1954.6 1960.7 791.9 858.8 871.4 879.9 925.0 20866.0 21700.8 21735.0 21857.9 22007.4 909.6 930.2 934.4 945.9 988.5 10556.8 11321.3 11347.9 11379.5 11493.1 484486.0 603014.0 609911.0 611179.0 616640.0 147115.0 154000.5 155415.2 155762.0 159713.0 995.1 1003.8 1023.5 1028.7 1042.2 19707.0 19860.7 20073.6 20128.0 20152.0 57200.1 58134.4 59462.5 59474.0 59898.7 88186.6 88200.0 88718.6 89615.0 90932.0 5038.8 7018.3 7679.0 7913.4 8294.2 9933.5 12767.2 12987.4 13339.0 13413.3 8872.0 10777.1 11025.0 11058.7 11382.6 9176.4 10732.4 10783.9 11241.6 11249.7 11010.2 11301.7 11435.4 11473.2 11512.4 7117.1 7298.8 7497.9 7502.0 7668.4 9210.7 10997.5 11060.5 11165.6 11233.7 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:5658.79 Median:4867.81 stddev:3185.41 (65.4%) stddev-sans-first:3178.93 21:10:43 INFO - PROCESS | 1651 | Values: 1488.1 1520.3 1697.2 1811.1 1837.8 8001.5 8420.4 8619.6 8954.3 8966.6 8585.5 8679.5 8790.8 8802.4 8818.2 2354.1 2401.7 2402.8 2409.8 2410.9 2361.3 2383.6 2394.0 2400.3 2407.9 2220.4 2226.8 2242.9 2243.8 2246.4 2312.4 2343.1 2373.1 2373.8 2389.7 2339.4 2375.8 2379.2 2385.0 2393.2 8711.0 8806.4 8827.3 8846.0 8864.0 4323.6 5365.6 5384.0 5388.8 5392.8 3689.1 3703.3 3734.1 3760.4 3769.6 1095.9 1096.4 1097.7 1097.8 1113.9 11354.9 11474.8 11608.9 11618.4 11651.6 4160.9 4471.0 4731.7 4832.4 4850.1 9798.2 9831.2 9832.5 9896.2 9901.7 5279.2 5336.7 5345.4 5362.3 5364.3 4068.8 4434.7 4743.7 4876.8 4903.1 3855.7 3930.1 3972.9 4005.4 4045.3 1300.4 1312.2 1314.9 1327.2 1329.6 803.5 838.2 883.2 895.0 898.0 4538.7 4858.8 5719.6 5742.7 5864.9 675.4 770.3 787.0 808.3 900.7 3406.8 3861.5 3929.9 3933.7 3992.6 10260.7 10301.7 10588.5 10656.6 10694.5 10563.8 10585.6 10628.9 10632.1 10677.8 8038.0 8108.4 8245.0 8294.0 8356.8 5758.5 5758.7 5818.3 5849.2 5857.9 9956.0 9977.7 10047.7 10057.9 10118.0 9759.9 10254.7 10283.9 10287.9 10335.4 6493.7 6508.6 6547.6 6942.8 7092.6 8388.7 8446.6 8462.1 8470.2 8497.2 7406.4 7524.4 7524.7 7529.2 7639.3 7331.7 7366.2 7381.5 7508.0 7531.1 5863.8 7034.4 7037.5 7051.8 7054.9 4628.7 4904.7 4965.4 5042.2 5048.3 4617.2 4638.0 4959.9 5152.0 5173.8 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4725.70 Median:5233.12 stddev:1541.77 (29.5%) stddev-sans-first:1509.63 21:10:43 INFO - PROCESS | 1651 | Values: 284.3 293.8 309.2 312.9 316.5 5398.3 5544.4 5679.7 5683.5 5700.3 5003.4 5176.6 5233.8 5616.2 5743.7 3399.8 3439.9 3657.4 3803.8 4130.6 3533.7 3818.9 4343.1 4352.1 4361.6 3610.7 3857.0 4164.0 4180.0 4217.5 4142.0 4181.8 4183.5 4239.4 4247.4 3011.9 3442.1 3624.1 3641.1 3667.5 5129.5 5179.9 5371.0 5483.2 5544.4 3883.0 4334.9 4515.7 4793.9 4889.8 4336.7 5488.5 5940.0 5961.0 5990.5 3470.8 3643.0 3869.3 3941.4 3972.4 5206.5 5232.4 5800.7 6272.2 6298.2 3257.0 3395.0 4034.4 4049.3 4061.9 3307.4 3714.0 3825.2 4052.2 4061.2 4102.5 4808.9 4840.2 4845.5 4887.3 5722.2 6001.3 6027.7 6136.3 6174.4 1253.5 1305.7 1335.6 1383.2 1397.7 743.5 913.9 931.8 934.7 938.7 4445.7 5263.7 5336.6 5474.7 5664.9 6164.3 6196.8 6197.3 6198.8 6242.4 4368.6 4718.7 5113.4 5348.1 5580.5 2841.5 3175.6 3252.5 3275.8 3289.5 5150.6 5782.8 6364.4 6497.5 6508.6 4835.4 5726.5 6124.6 6425.3 6450.6 5403.4 6521.5 6539.4 6596.2 6624.8 5727.4 6002.6 6041.7 6180.6 6235.7 6055.2 6096.8 6119.0 6176.7 6189.3 6147.9 6389.0 6514.7 6562.8 6654.2 3379.9 3560.9 3571.3 3738.7 4052.0 5853.5 6165.6 6273.8 6279.4 6297.2 4712.6 4842.0 4911.9 5199.9 5956.5 5849.4 6009.3 6092.4 6103.4 6141.4 4910.2 5475.8 5543.4 5601.8 5729.0 4830.0 4937.7 5661.9 5782.8 5986.6 5101.3 5397.3 5637.0 5825.2 5881.6 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:24238.10 Median:4474.54 stddev:39701.68 (887.3%) stddev-sans-first:39773.67 21:10:43 INFO - PROCESS | 1651 | Values: 685.4 706.4 723.4 763.7 815.0 15020.6 15746.7 15763.3 15786.8 15814.5 13184.7 13529.0 13570.2 13787.3 13943.8 842.3 843.2 853.9 855.3 860.2 675.3 853.1 854.1 856.3 858.8 704.9 852.9 872.9 899.7 900.1 873.3 889.0 890.2 890.9 891.0 657.6 660.7 662.7 666.2 669.4 14719.9 14981.6 15038.9 15062.2 15068.5 11218.2 11251.9 13603.5 13856.2 13878.9 10512.3 12403.7 12506.2 12578.5 12666.0 4464.9 4468.3 4513.7 4522.0 4636.0 120011.0 124838.4 125207.7 126075.4 126938.0 10788.8 10817.1 10856.1 10881.5 10915.8 20693.0 20885.8 21322.1 21340.9 21387.4 7628.4 7705.1 7781.5 7890.9 7919.6 4354.0 4480.8 4486.6 4582.7 4589.2 3385.8 3419.5 3487.9 3488.8 3518.8 626.3 629.5 647.0 664.9 675.5 532.7 558.4 588.8 598.8 600.4 8728.0 8733.7 8841.2 8894.9 9142.1 534.9 564.8 584.3 591.8 607.9 3645.6 4322.3 4358.1 4428.0 4466.1 85360.0 100798.5 141644.6 154813.0 161546.0 131254.0 139662.0 140884.0 142288.0 143332.0 67203.0 89292.0 101379.5 107948.0 111711.4 8285.2 8399.0 8450.4 8569.1 8630.0 65677.2 65776.0 66515.3 66616.0 66680.3 78313.0 85409.0 93348.1 101222.5 103916.5 10899.5 11179.5 11496.8 11539.4 11797.5 11293.3 11302.0 11878.5 12056.3 12237.8 11125.9 11490.9 11651.7 12051.6 12053.2 9466.4 10322.9 11038.2 11087.7 11355.3 11272.9 11533.7 11560.8 11669.5 11926.6 9361.4 9518.6 9681.9 9691.1 9982.1 8262.9 8492.3 9633.1 9797.7 9854.2 21:10:43 INFO - PROCESS | 1651 | -------- Summary: end -------- 21:10:43 INFO - PROCESS | 1651 | 21:10:43 INFO - TEST-INFO | 1651: exit 0 21:10:43 INFO - TEST-OK | dromaeo_css | took 1113606ms 21:10:43 INFO - TEST-START | kraken 21:10:43 INFO - operating with platform_type : mac_ 21:10:43 INFO - Initialising browser for kraken test... 21:10:43 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpe3jPf5/profile http://localhost:49272/getInfo.html) 21:10:46 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 21:10:46 INFO - PROCESS | 1665 | colorDepth:24 21:10:46 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 21:10:46 INFO - PROCESS | 1665 | __metrics 21:10:46 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2998: TypeError: this.tabs is undefined 21:10:47 INFO - TEST-INFO | 1665: exit 0 21:10:47 INFO - Browser initialized. 21:10:47 INFO - Running cycle 1/1 for kraken test... 21:10:47 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/T/tmpe3jPf5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:10:59 INFO - PROCESS | 1667 | RSS: Main: 243736576 21:10:59 INFO - PROCESS | 1667 | 21:11:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 21:11:03 INFO - PROCESS | 1667 | RSS: Main: 256716800 21:11:03 INFO - PROCESS | 1667 | 21:11:05 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 21:11:06 INFO - PROCESS | 1667 | RSS: Main: 265367552 21:11:06 INFO - PROCESS | 1667 | 21:11:09 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 21:11:10 INFO - PROCESS | 1667 | RSS: Main: 265154560 21:11:10 INFO - PROCESS | 1667 | 21:11:12 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 21:11:13 INFO - PROCESS | 1667 | RSS: Main: 267534336 21:11:13 INFO - PROCESS | 1667 | 21:11:15 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:11:15 INFO - PROCESS | 1667 | RSS: Main: 268058624 21:11:15 INFO - PROCESS | 1667 | 21:11:18 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 21:11:19 INFO - PROCESS | 1667 | RSS: Main: 268787712 21:11:19 INFO - PROCESS | 1667 | 21:11:22 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 21:11:23 INFO - PROCESS | 1667 | RSS: Main: 269008896 21:11:23 INFO - PROCESS | 1667 | 21:11:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 21:11:26 INFO - PROCESS | 1667 | RSS: Main: 269307904 21:11:26 INFO - PROCESS | 1667 | 21:11:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:11:28 INFO - PROCESS | 1667 | RSS: Main: 268468224 21:11:28 INFO - PROCESS | 1667 | 21:11:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:11:31 INFO - PROCESS | 1667 | RSS: Main: 268435456 21:11:31 INFO - PROCESS | 1667 | 21:11:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:11:34 INFO - PROCESS | 1667 | RSS: Main: 268759040 21:11:34 INFO - PROCESS | 1667 | 21:11:37 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:11:38 INFO - PROCESS | 1667 | RSS: Main: 268922880 21:11:38 INFO - PROCESS | 1667 | 21:11:41 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:11:41 INFO - PROCESS | 1667 | RSS: Main: 268890112 21:11:41 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 21:11:43 INFO - PROCESS | 1667 | RSS: Main: 270770176 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | __start_tp_report 21:11:43 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 21:11:43 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 21:11:43 INFO - PROCESS | 1667 | |i|pagename|runs| 21:11:43 INFO - PROCESS | 1667 | |0;ai-astar;160;116;120;114;116;157;168;173;119;132 21:11:43 INFO - PROCESS | 1667 | |1;audio-beat-detection;139;113;135;159;109;132;128;113;162;112 21:11:43 INFO - PROCESS | 1667 | |2;audio-dft;190;210;227;201;196;200;196;198;193;191 21:11:43 INFO - PROCESS | 1667 | |3;audio-fft;71;83;77;146;59;60;60;61;145;82 21:11:43 INFO - PROCESS | 1667 | |4;audio-oscillator;70;73;120;73;70;76;109;70;72;110 21:11:43 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;88;92;89;92;87;91;90;99;77 21:11:43 INFO - PROCESS | 1667 | |6;imaging-darkroom;118;91;93;134;150;132;97;134;146;97 21:11:43 INFO - PROCESS | 1667 | |7;imaging-desaturate;102;93;119;89;76;79;141;145;151;93 21:11:43 INFO - PROCESS | 1667 | |8;json-parse-financial;56;59;58;59;58;58;58;58;58;58 21:11:43 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;66;71;72;109;115;118;108;100;72;80 21:11:43 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;89;89;87;86;91;88;86;87;87;88 21:11:43 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;142;142;141;142;138;156;159;157;192;159 21:11:43 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;173;203;232;169;238;201;171;172;174;173 21:11:43 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;69;68;69;71;69;67;70;69;80;84 21:11:43 INFO - PROCESS | 1667 | __end_tp_report 21:11:43 INFO - PROCESS | 1667 | __start_cc_report 21:11:43 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,980 21:11:43 INFO - PROCESS | 1667 | __end_cc_report 21:11:43 INFO - PROCESS | 1667 | __startTimestamp1473307903910__endTimestamp 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | ------- Summary: start ------- 21:11:43 INFO - PROCESS | 1667 | Number of tests: 14 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:137.50 Median:144.50 stddev:24.11 (16.7%) stddev-sans-first:24.16 21:11:43 INFO - PROCESS | 1667 | Values: 160.0 116.0 120.0 114.0 116.0 157.0 168.0 173.0 119.0 132.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:130.20 Median:133.50 stddev:19.21 (14.4%) stddev-sans-first:20.11 21:11:43 INFO - PROCESS | 1667 | Values: 139.0 113.0 135.0 159.0 109.0 132.0 128.0 113.0 162.0 112.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:200.20 Median:199.00 stddev:11.03 (5.5%) stddev-sans-first:11.07 21:11:43 INFO - PROCESS | 1667 | Values: 190.0 210.0 227.0 201.0 196.0 200.0 196.0 198.0 193.0 191.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:84.40 Median:66.00 stddev:33.49 (50.7%) stddev-sans-first:35.17 21:11:43 INFO - PROCESS | 1667 | Values: 71.0 83.0 77.0 146.0 59.0 60.0 60.0 61.0 145.0 82.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:71.00 stddev:20.09 (28.3%) stddev-sans-first:20.64 21:11:43 INFO - PROCESS | 1667 | Values: 70.0 73.0 120.0 73.0 70.0 76.0 109.0 70.0 72.0 110.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:89.50 Median:90.50 stddev:5.48 (6.1%) stddev-sans-first:5.81 21:11:43 INFO - PROCESS | 1667 | Values: 90.0 88.0 92.0 89.0 92.0 87.0 91.0 90.0 99.0 77.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:119.20 Median:120.50 stddev:22.94 (19.0%) stddev-sans-first:24.33 21:11:43 INFO - PROCESS | 1667 | Values: 118.0 91.0 93.0 134.0 150.0 132.0 97.0 134.0 146.0 97.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:108.80 Median:77.50 stddev:28.15 (36.3%) stddev-sans-first:29.75 21:11:43 INFO - PROCESS | 1667 | Values: 102.0 93.0 119.0 89.0 76.0 79.0 141.0 145.0 151.0 93.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:0.82 (1.4%) stddev-sans-first:0.44 21:11:43 INFO - PROCESS | 1667 | Values: 56.0 59.0 58.0 59.0 58.0 58.0 58.0 58.0 58.0 58.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:91.10 Median:68.50 stddev:20.73 (30.3%) stddev-sans-first:19.90 21:11:43 INFO - PROCESS | 1667 | Values: 66.0 71.0 72.0 109.0 115.0 118.0 108.0 100.0 72.0 80.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:88.00 stddev:1.55 (1.8%) stddev-sans-first:1.58 21:11:43 INFO - PROCESS | 1667 | Values: 89.0 89.0 87.0 86.0 91.0 88.0 86.0 87.0 87.0 88.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:156.50 stddev:16.16 (10.3%) stddev-sans-first:16.66 21:11:43 INFO - PROCESS | 1667 | Values: 142.0 142.0 141.0 142.0 138.0 156.0 159.0 157.0 192.0 159.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.60 Median:187.50 stddev:26.49 (14.1%) stddev-sans-first:27.32 21:11:43 INFO - PROCESS | 1667 | Values: 173.0 203.0 232.0 169.0 238.0 201.0 171.0 172.0 174.0 173.0 21:11:43 INFO - PROCESS | 1667 | 21:11:43 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:69.50 stddev:5.66 (8.1%) stddev-sans-first:5.93 21:11:43 INFO - PROCESS | 1667 | Values: 69.0 68.0 69.0 71.0 69.0 67.0 70.0 69.0 80.0 84.0 21:11:43 INFO - PROCESS | 1667 | -------- Summary: end -------- 21:11:43 INFO - PROCESS | 1667 | 21:11:44 INFO - TEST-INFO | 1667: exit 0 21:11:44 INFO - TEST-OK | kraken | took 60909ms 21:11:44 INFO - SUITE-END | took 1174s 21:11:45 INFO - Completed test suite (00:19:34) 21:11:45 INFO - javascript benchmark 21:11:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7264.9087646839625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2778.5137600919834, 2797.978737760717, 2857.314244581301, 3390.898273051808, 3433.227523807144, 5341.332333458317, 5720.570957178218, 5813.738381772825, 5857.794977175799, 5901.734421951017, 5725.912076705423, 5781.0, 5852.561057920651, 5861.7948371807, 5879.911801322984, 5189.766460509267, 5277.498637629419, 5310.867228319304, 5381.704006279653, 5387.1111266640955, 5359.356877174744, 5359.624826262144, 5385.865353366177, 5432.972835135819, 5452.727363631822, 5159.613029022819, 5201.687898726089, 5254.7635356409055, 5291.126964050927, 5302.575793936476, 5243.0, 5243.9213411798855, 5275.103232450492, 5324.0150572144275, 5348.197770334481, 5303.549198318147, 5310.8141215057285, 5323.840284791462, 5349.545288650469, 5357.303550538444, 5331.360236771573, 5689.9146512802345, 5872.911906321408, 5878.823635290948, 5893.233879595668, 6169.0, 6176.073588961647, 6246.906296405557, 6250.0624906263965, 6262.060690896356, 5193.558547523465, 6120.721420533214, 6221.502279817649, 6281.24625044993, 6316.084167795644, 5952.672603006833, 5970.880582388415, 5992.131140984533, 6016.488598469092, 6050.183225264577, 6116.602420842631, 6311.737652469433, 6402.807915762534, 6448.903266451007, 6471.5146364022885, 5703.942960570341, 6074.271087469532, 6120.447133218794, 6230.0, 6263.404976527223, 6123.540734444934, 6176.042713379434, 6197.349278325801, 6250.968745156336, 6265.592736472115, 6139.57023008394, 6145.600535965148, 6223.906641400383, 6230.158928544679, 6239.875202495925, 4960.305557221992, 6136.693165341715, 6252.624842509464, 6252.749890004349, 6281.528885333618, 4917.803287868517, 4971.055499455164, 4982.501749824988, 4988.251762235694, 5005.1491246488185, 4440.111977604492, 4442.644588432918, 4451.621612162938, 4460.130274596422, 4470.2177119004045, 5894.233749612523, 6008.819735407945, 6026.728797204137, 6053.364396738367, 6054.576179667381, 6138.817583427401, 6170.197874276315, 6194.566380353423, 6215.875682486325, 6261.624302541771, 5974.133750606138, 5974.40255974399, 5985.371535988746, 6006.249218847644, 6031.185789918305, 5480.890382192334, 5492.340919089735, 5529.225908372831, 5538.0, 5541.861453463615, 6312.4634406076, 6423.518236132402, 6432.6140431572385, 6439.710213040518, 6446.774362897276, 6238.719257633326, 6258.092576576462, 6279.277883043508, 6283.340249273943, 6286.371362863677, 6441.0, 6471.676416179266, 6521.380468855451, 6522.934770652422, 6527.836804079936, 6127.0062805303205, 6150.769846030722, 6160.815175544741, 6202.224721909762, 6213.347598502273, 4987.750612469435, 6176.104464852661, 6192.195014648247, 6226.5641405101205, 6231.563790534619, 5218.869528261824, 5635.7601327707835, 6012.308584512837, 6219.346968568235, 6240.251169859646, 5594.944050559442, 5677.432256774289, 6105.247473116839, 6107.795737660903, 6143.0206349921145, 4732.455767586634, 4936.889199929987, 5725.312962444534, 6002.429769171922, 6130.785422510191, 6108.602940808833, 6176.7838125665385, 6189.0, 6191.1641928339095, 6302.1492098566105, 5990.161377407079, 6041.124037014696, 6041.728122234422, 6079.878402431838, 6130.50955923534], "value": 5708.859242090255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [479.58036717871863, 485.589676723169, 536.011059595047, 545.345585297643, 563.9887202255952, 31930.201744956386, 34357.96926092218, 37519.81240093795, 39791.403128953054, 39812.203755924864, 40955.59044409555, 41449.79275103628, 41461.792691036506, 41520.79239603805, 41529.58470415295, 9538.141567258945, 9629.518524073768, 9735.610575576968, 9737.1236588707, 9769.560369783341, 9498.667546635868, 9535.80928381432, 9579.0420957904, 9590.42457452555, 9612.711618651452, 9495.667651632195, 9587.856182157273, 9606.423614583113, 9634.036596340346, 9636.132748052674, 9500.192483638864, 9518.476483793389, 9572.042795720441, 9584.329096963216, 9596.136347728738, 9576.186024187953, 9628.66299679508, 9662.613495460173, 9667.178289845371, 9668.419894806264, 39208.0, 39458.60541394578, 39479.40780888289, 39627.0, 39725.20549589021, 3191.5531825544444, 3204.6314673812576, 3211.807291562514, 3267.9019629411155, 3287.917802054944, 30235.395292094254, 30520.38959220803, 30608.693913060808, 30680.53979190314, 31801.681983180104, 3198.296374797541, 3231.2568109334748, 3236.45151525678, 3288.588926384202, 3340.2985373071683, 453849.0, 455907.72046139557, 456944.0, 457627.0, 459484.0, 56683.716581416826, 56722.0, 56904.43095568991, 56916.71541642265, 57063.85872282614, 31031.534526982112, 33708.48311825973, 35321.29357412837, 36269.0, 59009.704951475826, 16073.437429689904, 16213.432529861399, 16221.513354599381, 16233.51299461018, 16240.918795405947, 11943.88056119445, 12437.129400941847, 12553.811692824615, 12559.058070644738, 12572.685682858002, 18175.545611359823, 18355.0, 18541.0, 18623.627527449375, 18651.81348186528, 7735.259566597583, 7855.72504962335, 7870.645820938072, 7889.303799683095, 7969.282764551102, 855.5209082913589, 941.9481928493861, 955.7180631713522, 1021.8313978193515, 1095.6603452929617, 29503.55744663832, 30619.234519136753, 31168.909088181805, 31828.0, 32549.18627034343, 780.9804754881173, 978.2125389061731, 999.860019597257, 1013.2704452793977, 1040.351043595909, 14428.0, 14830.88768342357, 14931.402743890123, 15081.321340539702, 15275.694486110215, 510928.0, 611355.0, 616607.0, 617865.0, 618252.0, 47893.28160077602, 53446.0, 53812.390017597, 54087.18869216965, 54531.72734136304, 1271.211848653822, 1329.8869596084442, 1330.3215360166191, 1330.733853229358, 1340.8592097829783, 27448.17655470339, 28497.857510712314, 28635.28411789722, 28949.276268092624, 28988.710112899444, 39411.802940985115, 40827.1834563313, 47733.0, 48495.75752121217, 50682.732931677005, 391426.0, 410779.3830925385, 453675.0, 474615.0, 474649.2535074743, 25174.867130979517, 25431.87284063568, 25543.744562554137, 25646.87176564105, 25882.741172588034, 33148.171295716835, 41258.968525787095, 42085.78957105195, 42768.57231427646, 42918.78540607277, 36601.63398366089, 36897.63102368942, 37452.812735936146, 37702.811485942395, 37885.62114378821, 36597.451038233914, 36984.445233320985, 37523.81238093792, 37731.81134094312, 37755.62244377631, 35836.0, 35883.0, 36758.63241367552, 36769.816150919076, 36914.07714807151, 32141.0, 33010.30763720343, 33169.0, 33262.833685831414, 33416.832915835264, 22074.44813879666, 22423.09273448616, 24761.133360332304, 25030.0, 25392.984280628567], "value": 18984.91398564463, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.5348115011508, 337.87667501362, 348.9616142224355, 349.577011815703, 373.47153777404975, 15469.0, 18188.545286367815, 19116.235350585994, 20270.89864550677, 20560.588788224228, 19582.70625940612, 20583.691244631344, 20690.68963965542, 20733.792662073374, 20884.89557552214, 5616.0171969905105, 5850.970745146279, 6140.723667434954, 6171.969140154293, 6173.413525715072, 5440.510354068133, 6057.424544668272, 6104.633721976674, 6144.109104179891, 6165.0, 5691.406406206269, 6094.451499365056, 6125.663088530151, 6144.5084393248435, 6159.26088869334, 5381.757820898049, 6129.0499972503885, 6145.508359331243, 6178.876422471548, 6186.536009799261, 5133.871653208662, 5466.480684334982, 5521.420250873641, 5817.7382017809305, 5998.0, 10939.507722152523, 12858.742825143538, 12996.0, 13040.934795326057, 24267.150649727173, 2290.5075408787025, 2312.90748370065, 2500.987495062513, 2817.8591070446396, 2892.2335581071034, 7214.819629509252, 10104.191664666809, 10262.127719143882, 13631.318434078355, 13845.446182152702, 1842.5946291815778, 1862.1341076399403, 1863.236073209991, 1893.943181704551, 1907.3038341005572, 110432.4478377611, 119193.61612767783, 123731.76268237382, 126408.10387844189, 127813.72186278111, 9397.483138427453, 10502.422366769748, 11483.301424165315, 11555.826662600068, 11902.880971190178, 14246.0, 14460.927695361455, 14463.0, 14471.204083775494, 14498.202598856953, 7637.8161384985415, 8242.711505097413, 8468.026176989602, 8495.660173592987, 8566.0, 8202.0, 8364.749057528285, 8433.578321083922, 8486.448380855225, 8554.01628812682, 3809.3333666608232, 4445.488768791631, 4532.320151977164, 4546.999660074778, 4616.722996620147, 1569.8194707608543, 1945.9902700486407, 1948.6395016921915, 1954.6383918975034, 1960.7156962240394, 791.8693415586479, 858.8153546987303, 871.4248595926658, 879.8856148700628, 924.9917589827121, 20866.0, 21700.782992170192, 21735.0, 21857.890710546344, 22007.449813754785, 909.5770466733001, 930.2000279759402, 934.3926447808979, 945.8581212818133, 988.5255077562666, 10556.832950114935, 11321.319971839062, 11347.921947415147, 11379.487923043484, 11493.080553555696, 484486.0, 603014.0, 609911.0, 611179.0, 616640.0, 147115.0, 154000.45999539862, 155415.22292388466, 155762.0, 159713.0, 995.0546681238162, 1003.799240151958, 1023.5138309303021, 1028.6554004408606, 1042.2183362478142, 19707.0, 19860.70208946838, 20073.598528029066, 20128.0, 20152.0, 57200.141997870895, 58134.418655814596, 59462.513437164416, 59474.0, 59898.70050649719, 88186.55906720426, 88200.0, 88718.55640721755, 89615.0, 90932.0, 5038.823641172688, 7018.2630823762765, 7678.963339949036, 7913.366930645419, 8294.212049855254, 9933.503324833584, 12767.233965962072, 12987.35063246815, 13339.0, 13413.262270574822, 8872.0, 10777.08394786452, 11025.007749302602, 11058.668239952814, 11382.601608943647, 9176.44941303524, 10732.356058636507, 10783.946080269548, 11241.60654377093, 11249.71875703114, 11010.174236932102, 11301.660950171508, 11435.371054592077, 11473.196876218584, 11512.36681982499, 7117.110361204849, 7298.817529561803, 7497.850042999218, 7501.962490187514, 7668.424868135024, 9210.677626283048, 10997.471788248258, 11060.502277397376, 11165.609203677832, 11233.66299011031], "value": 9480.344517781912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1488.1443170177151, 1520.2702702702702, 1697.176869218429, 1811.1216060210788, 1837.8070302618232, 8001.519908805476, 8420.368472364567, 8619.569021548929, 8954.3284253681, 8966.596503157365, 8585.527795971218, 8679.47923124613, 8790.780230494242, 8802.383833131684, 8818.20636142747, 2354.0819080558554, 2401.6757737705448, 2402.8077753779658, 2409.77107174819, 2410.915617953372, 2361.268006917861, 2383.5947888858936, 2393.9521209575796, 2400.3399065257017, 2407.9157229496973, 2220.4448887778058, 2226.7661895500983, 2242.876641784709, 2243.8317126215516, 2246.382244882654, 2312.4103353644714, 2343.0627748900406, 2373.0982226753895, 2373.774491423312, 2389.7012873390913, 2339.4385347516645, 2375.8099352051795, 2379.179183181817, 2385.022140922231, 2393.1674918968392, 8710.998235202906, 8806.383553151281, 8827.337949653802, 8846.02693703692, 8864.0, 4323.589259020388, 5365.597580181463, 5384.0, 5388.757505912244, 5392.757325920343, 3689.1330537323706, 3703.2593481303848, 3734.0851491384515, 3760.417135344026, 3769.566499852497, 1095.8520599719016, 1096.4298564746366, 1097.6542389147394, 1097.8033943002165, 1113.8551988241559, 11354.886451135548, 11474.770504589862, 11608.883911160865, 11618.360990145455, 11651.59219427316, 4160.916781664349, 4470.955290447119, 4731.668783185144, 4832.371791667061, 4850.054239423279, 9798.167155791694, 9831.213502919749, 9832.508374581243, 9896.208303335716, 9901.653442129491, 5279.234510995961, 5336.67979921206, 5345.4498195522865, 5362.302900622894, 5364.30264065669, 4068.7762173080173, 4434.667399945017, 4743.6916600421555, 4876.780544875489, 4903.141950158779, 3855.691544676419, 3930.1157239620857, 3972.920541589152, 4005.3991901214467, 4045.332520134145, 1300.3563236198142, 1312.1536608887213, 1314.8750868667462, 1327.2169420042221, 1329.5878277733934, 803.4897839871724, 838.2162677896187, 883.1654086887829, 894.9731508054768, 897.9640814367483, 4538.659600529973, 4858.8299409521205, 5719.628224165416, 5742.655440673573, 5864.941350586525, 675.4326365852708, 770.3375097416217, 786.9724559640385, 808.3210103513077, 900.684760333891, 3406.7615266931075, 3861.4593956846065, 3929.9214015719526, 3933.7246392752804, 3992.6007399260425, 10260.692179234635, 10301.742456438498, 10588.523516441624, 10656.573737050587, 10694.465276736131, 10563.788724225473, 10585.576576936835, 10628.893711062945, 10632.096271816983, 10677.786444271227, 8038.0, 8108.391870609727, 8245.0, 8294.0, 8356.791080222922, 5758.481736643722, 5758.740856661377, 5818.33089194748, 5849.151872978479, 5857.882842343044, 9955.950220248853, 9977.700668979942, 10047.748806279902, 10057.949710251401, 10118.0, 9759.853602195832, 10254.743631409274, 10283.897161028293, 10287.948560257151, 10335.431551264752, 6493.707783149864, 6508.642024688687, 6547.639879806657, 6942.826429339307, 7092.6099064551945, 8388.748337549883, 8446.619902104543, 8462.069172391155, 8470.15298470148, 8497.235248827636, 7406.370458511087, 7524.360429363565, 7524.736634217776, 7529.209433009455, 7639.312461878235, 7331.743388981574, 7366.189719130784, 7381.483296169216, 7508.0, 7531.096268447822, 5863.794767183128, 7034.366906978396, 7037.542559733601, 7051.753188638373, 7054.8712206046785, 4628.722276663411, 4904.653768729502, 4965.354503914468, 5042.168042272984, 5048.293238946477, 4617.191991401559, 4638.026014536985, 4959.851204463872, 5151.974240128776, 5173.844784656466], "value": 4538.831474326869, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.30062047363486, 293.82664228105415, 309.19300625367794, 312.9108204161814, 316.52205170193, 5398.325209348832, 5544.390117087117, 5679.671334752752, 5683.5169010634045, 5700.287464066992, 5003.39959204895, 5176.637635365526, 5233.822389962256, 5616.213730077792, 5743.712814359286, 3399.7702182926196, 3439.914002149941, 3657.3599620066516, 3803.7717736935733, 4130.628243458088, 3533.6643018913164, 3818.9427158592644, 4343.109662519176, 4352.107817897323, 4361.60745532902, 3610.7472476926628, 3856.9614303856883, 4164.043529094347, 4180.038591124028, 4217.514985776645, 4142.005918579519, 4181.790910454481, 4183.539810620845, 4239.448871646666, 4247.405363249148, 3011.891675826908, 3442.1050526863196, 3624.0939765058733, 3641.1261297288725, 3667.4865518827387, 5129.512696293883, 5179.860430705239, 5370.979513892348, 5483.150111732688, 5544.445555444423, 3882.9611703882883, 4334.875910803715, 4515.706479078882, 4793.9280910786365, 4889.828855990058, 4336.720667403124, 5488.53347465462, 5940.0, 5961.0, 5990.490808281302, 3470.8091054991964, 3642.9817850910576, 3869.303525365433, 3941.4087886817206, 3972.443857859902, 5206.505381988705, 5232.424433312332, 5800.680962547058, 6272.247330320391, 6298.181236439279, 3257.0, 3394.9660503395144, 4034.3948407738485, 4049.2913740095364, 4061.862678450039, 3307.371599396107, 3713.9600911744756, 3825.2349530094093, 4052.2300762855552, 4061.248668996245, 4102.50769907613, 4808.89395439051, 4840.249761287007, 4845.515448455197, 4887.315775791392, 5722.227499287626, 6001.339852616209, 6027.698615069229, 6136.2636483622255, 6174.413430724074, 1253.4672764075415, 1305.719270356859, 1335.626024713082, 1383.2392184298596, 1397.7134687389062, 743.4981387563373, 913.9040400757825, 931.7996630724291, 934.7382732834681, 938.7043081429327, 4445.688521886052, 5263.6840789802545, 5336.573074154058, 5474.671519708831, 5664.867026594698, 6164.291106522717, 6196.791625633048, 6197.343567295317, 6198.81403557894, 6242.406971337807, 4368.584984426474, 4718.669693121448, 5113.411957624847, 5348.064088784447, 5580.469855363734, 2841.5453527435925, 3175.5712978747574, 3252.4796032634663, 3275.836208189581, 3289.490129030004, 5150.613703972217, 5782.761653473984, 6364.363563643691, 6497.480201583862, 6508.642024688687, 4835.419749630067, 5726.455986681259, 6124.6325220486915, 6425.293217746044, 6450.580712253689, 5403.432639572867, 6521.510886683518, 6539.378759017885, 6596.208454985336, 6624.801255962136, 5727.398623144676, 6002.612412919583, 6041.728122234422, 6180.567360284737, 6235.657038862906, 6055.2430946131735, 6096.75612975476, 6119.033941906606, 6176.722047507783, 6189.319174890668, 6147.938520614736, 6389.0, 6514.654724299343, 6562.77030303937, 6654.236627293868, 3379.9155021123684, 3560.946585801267, 3571.2500374921556, 3738.7195960302543, 4052.0072582217545, 5853.473187413153, 6165.599236049642, 6273.765208484346, 6279.434850863444, 6297.173819592267, 4712.575868171881, 4841.95158048415, 4911.852644420673, 5199.896002080013, 5956.493698035715, 5849.420656422827, 6009.308929473166, 6092.360302168208, 6103.443621876393, 6141.3551577085545, 4910.165271903714, 5475.753591088331, 5543.445655434424, 5601.795613943022, 5728.971355143198, 4830.033993201304, 4937.703737775745, 5661.915071273852, 5782.7686892523825, 5986.55100867428, 5101.311322971352, 5397.298351214474, 5637.0, 5825.155352473783, 5881.588288819741], "value": 4232.402801489713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.4276678973057, 706.3960313931589, 723.3706675192583, 763.736510903738, 814.9511029338238, 15020.624484387881, 15746.685066298667, 15763.290651920663, 15786.842131578695, 15814.525564233063, 13184.670383240424, 13529.0, 13570.185788852652, 13787.310634468262, 13943.790843137362, 842.3177226446583, 843.173689784012, 853.9402241843073, 855.2815634866711, 860.1699360117485, 675.3246753246754, 853.0829358439671, 854.0733304364771, 856.25933567464, 858.8239410920778, 704.8555046215539, 852.9445586036919, 872.9083446238149, 899.6806133822497, 900.0954041188596, 873.3013589128703, 889.0353965946923, 890.1810334492251, 890.8975467821153, 890.9955450222773, 657.641585335993, 660.7125900233414, 662.7249691378072, 666.247140730971, 669.4042302350912, 14719.852801471956, 14981.625459363495, 15038.924805376013, 15062.171580563065, 15068.472603458937, 11218.214724969255, 11251.887481125166, 13603.523876664269, 13856.237906915116, 13878.93060534701, 10512.316699414514, 12403.689907752288, 12506.249625022438, 12578.496860125584, 12666.0, 4464.933026004613, 4468.2850743881145, 4513.661475389359, 4521.977390113061, 4635.95364046362, 120011.0, 124838.37580812039, 125207.74792252052, 126075.3696231513, 126938.0, 10788.838167427495, 10817.080548153337, 10856.131509479223, 10881.455927203608, 10915.781684366268, 20693.0, 20885.79114208869, 21322.14711411526, 21340.893295533733, 21387.358379248646, 7628.427867909929, 7705.095627255903, 7781.494202876908, 7890.921090789134, 7919.643616037292, 4354.042110735633, 4480.798364073559, 4486.6186374157905, 4582.725036497821, 4589.173948689268, 3385.8476368563474, 3419.504171895111, 3487.9302413952087, 3488.8081155536183, 3518.7888726676483, 626.2766504687003, 629.471244154912, 647.0165348669996, 664.8936170212743, 675.4596322941725, 532.7496076843877, 558.3634656491603, 588.8204097750228, 598.7814796888398, 600.4115966352998, 8728.0, 8733.694320698745, 8841.204291613785, 8894.911050889537, 9142.085791420805, 534.8689571055116, 564.7599770097692, 584.3017593975159, 591.7632946821305, 607.8936186167404, 3645.5989841117457, 4322.330038843984, 4358.106588149421, 4427.977860110679, 4466.129104824593, 85360.0, 100798.4960075195, 141644.5835541652, 154813.0, 161546.0, 131254.0, 139662.0, 140884.0, 142288.0, 143332.0, 67203.0, 89292.0, 101379.46551336275, 107948.0, 111711.44144279226, 8285.171482851907, 8398.958005209935, 8450.408471406943, 8569.143085691381, 8629.956850215709, 65677.24104902495, 65776.0, 66515.33711657053, 66616.0, 66680.33319666742, 78313.0, 85409.0, 93348.13303734023, 101222.46943826463, 103916.48041759743, 10899.509522071367, 11179.496922638664, 11496.827547586625, 11539.423028848692, 11797.52809887595, 11293.265937714023, 11302.0, 11878.524859005889, 12056.336901470153, 12237.75524489523, 11125.944370278097, 11490.88509114898, 11651.650450486499, 12051.57819476314, 12053.156279060382, 9466.384684995728, 10322.948385258025, 11038.227324087236, 11087.667369978913, 11355.261907975955, 11272.943635281772, 11533.653990380302, 11560.826587601025, 11669.474873630877, 11926.582569610022, 9361.4383137012, 9518.571664275263, 9681.903180968382, 9691.127798497888, 9982.051705088004, 8262.917370826455, 8492.282469609665, 9633.08485693858, 9797.71433122269, 9854.211663066793], "value": 7447.751374453325, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1605.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 116.0, 120.0, 114.0, 116.0, 157.0, 168.0, 173.0, 119.0, 132.0], "value": 137.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 113.0, 135.0, 159.0, 109.0, 132.0, 128.0, 113.0, 162.0, 112.0], "value": 130.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 210.0, 227.0, 201.0, 196.0, 200.0, 196.0, 198.0, 193.0, 191.0], "value": 200.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 83.0, 77.0, 146.0, 59.0, 60.0, 60.0, 61.0, 145.0, 82.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 120.0, 73.0, 70.0, 76.0, 109.0, 70.0, 72.0, 110.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 92.0, 89.0, 92.0, 87.0, 91.0, 90.0, 99.0, 77.0], "value": 89.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 91.0, 93.0, 134.0, 150.0, 132.0, 97.0, 134.0, 146.0, 97.0], "value": 119.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 93.0, 119.0, 89.0, 76.0, 79.0, 141.0, 145.0, 151.0, 93.0], "value": 108.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 58.0, 59.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 71.0, 72.0, 109.0, 115.0, 118.0, 108.0, 100.0, 72.0, 80.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 87.0, 86.0, 91.0, 88.0, 86.0, 87.0, 87.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 141.0, 142.0, 138.0, 156.0, 159.0, 157.0, 192.0, 159.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 203.0, 232.0, 169.0, 238.0, 201.0, 171.0, 172.0, 174.0, 173.0], "value": 190.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 71.0, 69.0, 67.0, 70.0, 69.0, 80.0, 84.0], "value": 71.6, "unit": "score"}]}]} 21:11:45 INFO - Return code: 0 21:11:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:11:45 ERROR - # TBPL SUCCESS # 21:11:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:11:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:11:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:11:45 INFO - 2016-09-07 21:11:45.227 screenresolution[1672:10402] starting screenresolution argv=screenresolution get 21:11:45 INFO - 2016-09-07 21:11:45.230 screenresolution[1672:10402] Display 0: 1600x1200x32@60 21:11:45 INFO - 2016-09-07 21:11:45.236 screenresolution[1673:10405] starting screenresolution argv=screenresolution list 21:11:45 INFO - Available Modes on Display 0 21:11:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:11:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:11:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:11:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:11:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:11:45 INFO - Intel Iris: 21:11:45 INFO - Chipset Model: Intel Iris 21:11:45 INFO - Type: GPU 21:11:45 INFO - Bus: Built-In 21:11:45 INFO - VRAM (Dynamic, Max): 1536 MB 21:11:45 INFO - Vendor: Intel (0x8086) 21:11:45 INFO - Device ID: 0x0a2e 21:11:45 INFO - Revision ID: 0x0009 21:11:45 INFO - Displays: 21:11:45 INFO - Display: 21:11:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:11:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:11:45 INFO - Display Serial Number: 1600x1200 60 21:11:45 INFO - Main Display: Yes 21:11:45 INFO - Mirror: Off 21:11:45 INFO - Online: Yes 21:11:45 INFO - Rotation: Supported 21:11:45 INFO - Return code: 0 21:11:45 INFO - Running post-action listener: _resource_record_post_action 21:11:45 INFO - [mozharness: 2016-09-08 04:11:45.471224Z] Finished run-tests step (success) 21:11:45 INFO - Running post-run listener: _resource_record_post_run 21:11:45 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 37139456; Write bytes: 705561088; Read time: 385; Write time: 2095 21:11:45 INFO - TinderboxPrint: CPU usage
54.3% 21:11:45 INFO - TinderboxPrint: I/O read bytes / time
37,139,456 / 385 21:11:45 INFO - TinderboxPrint: I/O write bytes / time
705,561,088 / 2,095 21:11:45 INFO - TinderboxPrint: CPU idle
2,214.6 (45.7%) 21:11:45 INFO - TinderboxPrint: CPU system
980.3 (20.2%) 21:11:45 INFO - TinderboxPrint: CPU user
1,646.8 (34.0%) 21:11:45 INFO - TinderboxPrint: Swap in / out
442,814,464 / 0 21:11:45 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390015488; Write bytes: 384341504; Read time: 29324; Write time: 725 21:11:45 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36185088; Write bytes: 297118720; Read time: 370; Write time: 1322 21:11:45 INFO - Running post-run listener: _upload_blobber_files 21:11:45 INFO - Blob upload gear active. 21:11:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:11:45 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 21:11:45 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'] 21:11:45 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 21:11:46 INFO - (blobuploader) - INFO - Open directory for files ... 21:11:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:11:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:11:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:11:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:11:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:11:47 INFO - (blobuploader) - INFO - Done attempting. 21:11:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:11:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:11:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:11:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:11:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:11:48 INFO - (blobuploader) - INFO - Done attempting. 21:11:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:11:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:11:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:11:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:11:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:11:51 INFO - (blobuploader) - INFO - Done attempting. 21:11:51 INFO - (blobuploader) - INFO - Iteration through files over. 21:11:51 INFO - Return code: 0 21:11:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:11:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:11:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8e24b2ca61a87f6a5857e30184b5b84a5d6d9b7cdd30ea3ec2a513485513c0b0af5ec9779ec07d9783cca53dae8565a1409180abebc305d24f318be6899c947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301c0adc0ccd2b3689c2faf0678d57eb0d663c97f250ce774248919dba46df72eb6bfe891630ffd0579a582cd325b423027ff1d4562d003fa178f939a7965e54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e77e3f9b1d751ef3a3011122f232a3d01a6730f3aace4b1f107ec435e419e2e69c571eebd497e57b9c8bf11603749e93abb81bc0edcc43b20449e79dfbfb5aa2"} 21:11:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:11:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:11:51 INFO - Contents: 21:11:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d8e24b2ca61a87f6a5857e30184b5b84a5d6d9b7cdd30ea3ec2a513485513c0b0af5ec9779ec07d9783cca53dae8565a1409180abebc305d24f318be6899c947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301c0adc0ccd2b3689c2faf0678d57eb0d663c97f250ce774248919dba46df72eb6bfe891630ffd0579a582cd325b423027ff1d4562d003fa178f939a7965e54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e77e3f9b1d751ef3a3011122f232a3d01a6730f3aace4b1f107ec435e419e2e69c571eebd497e57b9c8bf11603749e93abb81bc0edcc43b20449e79dfbfb5aa2"} 21:11:51 INFO - Running post-run listener: copy_logs_to_upload_dir 21:11:51 INFO - Copying logs to upload dir... 21:11:51 INFO - mkdir: /builds/slave/test/build/upload/logs 21:11:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.839385 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-09-07 21:11:51.216428) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 21:11:51.219783) ========= 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.MQORKFtbAb/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.atbrQeBWxR/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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/d8e24b2ca61a87f6a5857e30184b5b84a5d6d9b7cdd30ea3ec2a513485513c0b0af5ec9779ec07d9783cca53dae8565a1409180abebc305d24f318be6899c947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301c0adc0ccd2b3689c2faf0678d57eb0d663c97f250ce774248919dba46df72eb6bfe891630ffd0579a582cd325b423027ff1d4562d003fa178f939a7965e54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e77e3f9b1d751ef3a3011122f232a3d01a6730f3aace4b1f107ec435e419e2e69c571eebd497e57b9c8bf11603749e93abb81bc0edcc43b20449e79dfbfb5aa2"} build_url:https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/bIZYdhwPRI2rzNB1MUA33w/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/d8e24b2ca61a87f6a5857e30184b5b84a5d6d9b7cdd30ea3ec2a513485513c0b0af5ec9779ec07d9783cca53dae8565a1409180abebc305d24f318be6899c947", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/301c0adc0ccd2b3689c2faf0678d57eb0d663c97f250ce774248919dba46df72eb6bfe891630ffd0579a582cd325b423027ff1d4562d003fa178f939a7965e54", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e77e3f9b1d751ef3a3011122f232a3d01a6730f3aace4b1f107ec435e419e2e69c571eebd497e57b9c8bf11603749e93abb81bc0edcc43b20449e79dfbfb5aa2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 21:11:51.253586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 21:11:51.253922) ========= 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.MQORKFtbAb/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.atbrQeBWxR/Listeners TMPDIR=/var/folders/8w/f4pjrf8x3_z5wkxqw3mwdcg400000w/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.005027 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 21:11:51.302272) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 21:11:51.302617) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 21:11:51.302957) ========= ========= Total master_lag: 0.21 =========