builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0224 starttime: 1474655929.44 results: success (0) buildid: 20160923101725 builduid: 4996e7026b864fd19f6eeb3186d92dcf revision: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:49.435771) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:49.436129) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:49.436394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:49.631961) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:49.632224) ========= 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.A9FZl0HjoP/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.hI44BLZRva/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-23 11:38:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 20.4M=0.001s 2016-09-23 11:38:50 (20.4 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.606784 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:50.266481) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:50.269852) ========= 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.A9FZl0HjoP/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.hI44BLZRva/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.026972 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:50.318163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 11:38:50.318477) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c --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 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.A9FZl0HjoP/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.hI44BLZRva/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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-23 11:38:50,430 truncating revision to first 12 chars 2016-09-23 11:38:50,430 Setting DEBUG logging. 2016-09-23 11:38:50,430 attempt 1/10 2016-09-23 11:38:50,430 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/76fd7dbb20d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 11:38:51,192 unpacking tar archive at: fx-team-76fd7dbb20d5/testing/mozharness/ program finished with exit code 0 elapsedTime=1.027082 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 11:38:51.374042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:51.374350) ========= script_repo_revision: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:51.374738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:51.375001) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 11:38:51.393477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 11:38:51.393774) ========= /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.A9FZl0HjoP/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.hI44BLZRva/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:38:51 INFO - MultiFileLogger online at 20160923 11:38:51 in /builds/slave/test 11:38:51 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 11:38:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:38:51 INFO - {'append_to_log': False, 11:38:51 INFO - 'base_work_dir': '/builds/slave/test', 11:38:51 INFO - 'blob_upload_branch': 'Fx-Team', 11:38:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:38:51 INFO - 'branch': 'Fx-Team', 11:38:51 INFO - 'buildbot_json_path': 'buildprops.json', 11:38:51 INFO - 'config_files': ('talos/mac_config.py',), 11:38:51 INFO - 'default_actions': ('clobber', 11:38:51 INFO - 'read-buildbot-config', 11:38:51 INFO - 'download-and-extract', 11:38:51 INFO - 'populate-webroot', 11:38:51 INFO - 'create-virtualenv', 11:38:51 INFO - 'install', 11:38:51 INFO - 'run-tests'), 11:38:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:38:51 INFO - 'download_minidump_stackwalk': True, 11:38:51 INFO - 'download_symbols': 'ondemand', 11:38:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:38:51 INFO - 'tooltool.py': '/tools/tooltool.py', 11:38:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:38:51 INFO - '/tools/misc-python/virtualenv.py')}, 11:38:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:38:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:38:51 INFO - 'installer_path': 'installer.exe', 11:38:51 INFO - 'log_level': 'info', 11:38:51 INFO - 'log_name': 'talos', 11:38:51 INFO - 'log_to_console': True, 11:38:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:38:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:38:51 INFO - 'opt_config_files': (), 11:38:51 INFO - 'pip_index': False, 11:38:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:38:51 INFO - 'cmd': ('bash', 11:38:51 INFO - '-c', 11:38:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:38:51 INFO - 'enabled': True, 11:38:51 INFO - 'halt_on_failure': False, 11:38:51 INFO - 'name': 'check_screen_resolution'},), 11:38:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:38:51 INFO - 'cmd': ('bash', 11:38:51 INFO - '-c', 11:38:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:38:51 INFO - 'enabled': True, 11:38:51 INFO - 'halt_on_failure': False, 11:38:51 INFO - 'name': 'check_screen_resolution'},), 11:38:51 INFO - 'run_cmd_checks_enabled': True, 11:38:51 INFO - 'sps_profile': False, 11:38:51 INFO - 'sps_profile_interval': 0, 11:38:51 INFO - 'suite': 'dromaeojs-e10s', 11:38:51 INFO - 'system_bits': '32', 11:38:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:38:51 INFO - 'title': 't-yosemite-r7-0224', 11:38:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:38:51 INFO - 'use_talos_json': True, 11:38:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:38:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:38:51 INFO - 'work_dir': 'build'} 11:38:51 INFO - [mozharness: 2016-09-23 18:38:51.612474Z] Running clobber step. 11:38:51 INFO - Running pre-action listener: _resource_record_pre_action 11:38:51 INFO - Running main action method: clobber 11:38:51 INFO - rmtree: /builds/slave/test/build 11:38:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:38:53 INFO - Running post-action listener: _resource_record_post_action 11:38:53 INFO - [mozharness: 2016-09-23 18:38:53.605043Z] Finished clobber step (success) 11:38:53 INFO - [mozharness: 2016-09-23 18:38:53.605276Z] Running read-buildbot-config step. 11:38:53 INFO - Running pre-action listener: _resource_record_pre_action 11:38:53 INFO - Running main action method: read_buildbot_config 11:38:53 INFO - Using buildbot properties: 11:38:53 INFO - { 11:38:53 INFO - "project": "", 11:38:53 INFO - "product": "firefox", 11:38:53 INFO - "script_repo_revision": "production", 11:38:53 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:38:53 INFO - "repository": "", 11:38:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:38:53 INFO - "buildid": "20160923101725", 11:38:53 INFO - "pgo_build": "False", 11:38:53 INFO - "basedir": "/builds/slave/test", 11:38:53 INFO - "buildnumber": 18, 11:38:53 INFO - "slavename": "t-yosemite-r7-0224", 11:38:53 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 11:38:53 INFO - "platform": "yosemite_r7", 11:38:53 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 11:38:53 INFO - "branch": "fx-team", 11:38:53 INFO - "repo_path": "integration/fx-team", 11:38:53 INFO - "revision": "76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c", 11:38:53 INFO - "stage_platform": "macosx64", 11:38:53 INFO - "builduid": "4996e7026b864fd19f6eeb3186d92dcf", 11:38:53 INFO - "slavebuilddir": "test" 11:38:53 INFO - } 11:38:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 11:38:53 INFO - Running post-action listener: _resource_record_post_action 11:38:53 INFO - [mozharness: 2016-09-23 18:38:53.610989Z] Finished read-buildbot-config step (success) 11:38:53 INFO - [mozharness: 2016-09-23 18:38:53.611213Z] Running download-and-extract step. 11:38:53 INFO - Running pre-action listener: _resource_record_pre_action 11:38:53 INFO - Running main action method: download_and_extract 11:38:53 INFO - mkdir: /builds/slave/test/build/tests 11:38:53 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')]} 11:38:53 INFO - trying https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 11:38:53 INFO - Downloading https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:38:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 11:38:54 INFO - Downloaded 1199 bytes. 11:38:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 11:38:54 INFO - Using the following test package requirements: 11:38:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:38:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 11:38:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 11:38:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'jsshell-mac.zip'], 11:38:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 11:38:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 11:38:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 11:38:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 11:38:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 11:38:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 11:38:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 11:38:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:38:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:38:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:38:54 INFO - Fetch https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:38:55 INFO - Expected file size: 16438847 11:39:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:39:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 11:39:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:39:02 INFO - Fetch https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 11:39:03 INFO - Expected file size: 16438847 11:39:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 11:39:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:39:10 INFO - Fetch https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 11:39:10 INFO - Expected file size: 14414059 11:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:11 INFO - trying https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:39:11 INFO - Downloading https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 11:39:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 11:39:14 INFO - Downloaded 111556915 bytes. 11:39:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:39:14 INFO - mkdir: /builds/slave/test/properties 11:39:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:39:14 INFO - Writing to file /builds/slave/test/properties/build_url 11:39:14 INFO - Contents: 11:39:14 INFO - build_url:https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 11:39:15 INFO - Running post-action listener: _resource_record_post_action 11:39:15 INFO - Running post-action listener: set_extra_try_arguments 11:39:15 INFO - [mozharness: 2016-09-23 18:39:15.165853Z] Finished download-and-extract step (success) 11:39:15 INFO - [mozharness: 2016-09-23 18:39:15.165985Z] Running populate-webroot step. 11:39:15 INFO - Running pre-action listener: _resource_record_pre_action 11:39:15 INFO - Running main action method: populate_webroot 11:39:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:39:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:39:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:39:15 INFO - '--tppagecycles', 11:39:15 INFO - '7'], 11:39:15 INFO - 'tests': ['tsvgm']}}, 11:39:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:39:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:39:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:39:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:39:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:39:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['damp', 'tps']}, 11:39:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'tests': ['damp', 'tps']}, 11:39:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['dromaeo_dom']}, 11:39:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:39:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['basic_compositor_video']}, 11:39:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:39:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['a11yr', 11:39:15 INFO - 'ts_paint', 11:39:15 INFO - 'tpaint', 11:39:15 INFO - 'sessionrestore', 11:39:15 INFO - 'sessionrestore_no_auto_restore', 11:39:15 INFO - 'tabpaint']}, 11:39:15 INFO - 'other-e10s': {'tests': ['a11yr', 11:39:15 INFO - 'ts_paint', 11:39:15 INFO - 'tpaint', 11:39:15 INFO - 'sessionrestore', 11:39:15 INFO - 'sessionrestore_no_auto_restore', 11:39:15 INFO - 'tabpaint']}, 11:39:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:39:15 INFO - 'ts_paint', 11:39:15 INFO - 'tpaint', 11:39:15 INFO - 'sessionrestore', 11:39:15 INFO - 'sessionrestore_no_auto_restore', 11:39:15 INFO - 'tabpaint']}, 11:39:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:39:15 INFO - 'ts_paint', 11:39:15 INFO - 'tpaint', 11:39:15 INFO - 'sessionrestore', 11:39:15 INFO - 'sessionrestore_no_auto_restore', 11:39:15 INFO - 'tabpaint']}, 11:39:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['a11yr', 11:39:15 INFO - 'ts_paint', 11:39:15 INFO - 'tpaint', 11:39:15 INFO - 'sessionrestore', 11:39:15 INFO - 'sessionrestore_no_auto_restore', 11:39:15 INFO - 'tabpaint']}, 11:39:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['a11yr', 11:39:15 INFO - 'ts_paint', 11:39:15 INFO - 'tpaint', 11:39:15 INFO - 'sessionrestore', 11:39:15 INFO - 'sessionrestore_no_auto_restore', 11:39:15 INFO - 'tabpaint']}, 11:39:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['tsvgx', 11:39:15 INFO - 'tsvgr_opacity', 11:39:15 INFO - 'tart', 11:39:15 INFO - 'tscrollx', 11:39:15 INFO - 'cart']}, 11:39:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:39:15 INFO - 'tsvgr_opacity', 11:39:15 INFO - 'tart', 11:39:15 INFO - 'tscrollx', 11:39:15 INFO - 'cart']}, 11:39:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'talos_options': ['--disable-e10s'], 11:39:15 INFO - 'tests': ['tp5o']}, 11:39:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'tests': ['tp5o']}, 11:39:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'talos_options': ['--disable-e10s', 11:39:15 INFO - '--xperf_path', 11:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:15 INFO - 'tests': ['tp5n']}, 11:39:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:39:15 INFO - 'talos_options': ['--xperf_path', 11:39:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:39:15 INFO - 'tests': ['tp5n']}}, 11:39:15 INFO - 'talos.zip': {'path': '', 11:39:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:39:15 INFO - Running post-action listener: _resource_record_post_action 11:39:15 INFO - [mozharness: 2016-09-23 18:39:15.184475Z] Finished populate-webroot step (success) 11:39:15 INFO - [mozharness: 2016-09-23 18:39:15.184599Z] Running create-virtualenv step. 11:39:15 INFO - Running pre-action listener: _resource_record_pre_action 11:39:15 INFO - Running main action method: create_virtualenv 11:39:15 INFO - Creating virtualenv /builds/slave/test/build/venv 11:39:15 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 11:39:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:39:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:39:15 INFO - Using real prefix '/tools/python27' 11:39:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:39:16 INFO - Installing distribute.............................................................................................................................................................................................done. 11:39:18 INFO - Installing pip.................done. 11:39:18 INFO - Return code: 0 11:39:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:39:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:18 INFO - 'HOME': '/Users/cltbld', 11:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:18 INFO - 'LOGNAME': 'cltbld', 11:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:18 INFO - 'MOZ_NO_REMOTE': '1', 11:39:18 INFO - 'NO_EM_RESTART': '1', 11:39:18 INFO - 'PAGER': '/bin/cat', 11:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:18 INFO - 'PWD': '/builds/slave/test', 11:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:18 INFO - 'SHELL': '/bin/bash', 11:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:18 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:18 INFO - 'USER': 'cltbld', 11:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:18 INFO - 'XPC_FLAGS': '0x0', 11:39:18 INFO - 'XPC_SERVICE_NAME': '0', 11:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:19 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 11:39:19 INFO - Cleaning up... 11:39:19 INFO - Return code: 0 11:39:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:39: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')]} 11:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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')]} 11:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39: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', '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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 11:39: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 psutil>=3.1.1 11:39:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:19 INFO - 'HOME': '/Users/cltbld', 11:39:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:19 INFO - 'LOGNAME': 'cltbld', 11:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:19 INFO - 'MOZ_NO_REMOTE': '1', 11:39:19 INFO - 'NO_EM_RESTART': '1', 11:39:19 INFO - 'PAGER': '/bin/cat', 11:39:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:19 INFO - 'PWD': '/builds/slave/test', 11:39:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:19 INFO - 'SHELL': '/bin/bash', 11:39:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:19 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:19 INFO - 'USER': 'cltbld', 11:39:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:19 INFO - 'XPC_FLAGS': '0x0', 11:39:19 INFO - 'XPC_SERVICE_NAME': '0', 11:39:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:19 INFO - Downloading/unpacking psutil>=3.1.1 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:39:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:22 INFO - Installing collected packages: psutil 11:39:22 INFO - Running setup.py install for psutil 11:39:22 INFO - building 'psutil._psutil_osx' extension 11:39:22 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 11:39:23 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 11:39:23 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 11:39:23 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 11:39:23 INFO - building 'psutil._psutil_posix' extension 11:39:23 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 11:39:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:39:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:39:23 INFO - ^ 11:39:23 INFO - 1 warning generated. 11:39:23 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 11:39:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:39:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:39:23 INFO - Successfully installed psutil 11:39:23 INFO - Cleaning up... 11:39:23 INFO - Return code: 0 11:39:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:23 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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:23 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 11:39:23 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 11:39:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:23 INFO - 'HOME': '/Users/cltbld', 11:39:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:23 INFO - 'LOGNAME': 'cltbld', 11:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:23 INFO - 'MOZ_NO_REMOTE': '1', 11:39:23 INFO - 'NO_EM_RESTART': '1', 11:39:23 INFO - 'PAGER': '/bin/cat', 11:39:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:23 INFO - 'PWD': '/builds/slave/test', 11:39:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:23 INFO - 'SHELL': '/bin/bash', 11:39:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:23 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:23 INFO - 'USER': 'cltbld', 11:39:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:23 INFO - 'XPC_FLAGS': '0x0', 11:39:23 INFO - 'XPC_SERVICE_NAME': '0', 11:39:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:39:24 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 11:39:24 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 11:39:24 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 11:39:24 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 11:39:24 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 11:39:24 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 11:39:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:39:26 INFO - Installing collected packages: mozsystemmonitor 11:39:26 INFO - Running setup.py install for mozsystemmonitor 11:39:26 INFO - Successfully installed mozsystemmonitor 11:39:26 INFO - Cleaning up... 11:39:26 INFO - Return code: 0 11:39:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:39:26 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')]} 11:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:26 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')]} 11:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:26 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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:26 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 11:39:26 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 11:39:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:26 INFO - 'HOME': '/Users/cltbld', 11:39:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:26 INFO - 'LOGNAME': 'cltbld', 11:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:26 INFO - 'MOZ_NO_REMOTE': '1', 11:39:26 INFO - 'NO_EM_RESTART': '1', 11:39:26 INFO - 'PAGER': '/bin/cat', 11:39:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:26 INFO - 'PWD': '/builds/slave/test', 11:39:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:26 INFO - 'SHELL': '/bin/bash', 11:39:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:26 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:26 INFO - 'USER': 'cltbld', 11:39:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:26 INFO - 'XPC_FLAGS': '0x0', 11:39:26 INFO - 'XPC_SERVICE_NAME': '0', 11:39:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:27 INFO - Downloading/unpacking jsonschema==2.5.1 11:39:27 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 11:39:27 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 11:39:27 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 11:39:27 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 11:39:27 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 11:39:27 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 11:39:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:39:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:39:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:39:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:39:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:39:30 INFO - warning: no files found matching '*.txt' 11:39:30 INFO - no previously-included directories found matching 'build' 11:39:30 INFO - no previously-included directories found matching 'dist' 11:39:30 INFO - no previously-included directories found matching '.git*' 11:39:30 INFO - Installing collected packages: jsonschema, functools32 11:39:30 INFO - Running setup.py install for functools32 11:39:30 INFO - warning: no files found matching '*.txt' 11:39:30 INFO - no previously-included directories found matching 'build' 11:39:30 INFO - no previously-included directories found matching 'dist' 11:39:30 INFO - no previously-included directories found matching '.git*' 11:39:30 INFO - Successfully installed jsonschema functools32 11:39:30 INFO - Cleaning up... 11:39:30 INFO - Return code: 0 11:39:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:30 INFO - 'HOME': '/Users/cltbld', 11:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:30 INFO - 'LOGNAME': 'cltbld', 11:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:30 INFO - 'MOZ_NO_REMOTE': '1', 11:39:30 INFO - 'NO_EM_RESTART': '1', 11:39:30 INFO - 'PAGER': '/bin/cat', 11:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:30 INFO - 'PWD': '/builds/slave/test', 11:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:30 INFO - 'SHELL': '/bin/bash', 11:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:30 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:30 INFO - 'USER': 'cltbld', 11:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:30 INFO - 'XPC_FLAGS': '0x0', 11:39:30 INFO - 'XPC_SERVICE_NAME': '0', 11:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:39:30 INFO - Cleaning up... 11:39:30 INFO - Return code: 0 11:39:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:39:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:30 INFO - 'HOME': '/Users/cltbld', 11:39:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:30 INFO - 'LOGNAME': 'cltbld', 11:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:30 INFO - 'MOZ_NO_REMOTE': '1', 11:39:30 INFO - 'NO_EM_RESTART': '1', 11:39:30 INFO - 'PAGER': '/bin/cat', 11:39:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:30 INFO - 'PWD': '/builds/slave/test', 11:39:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:30 INFO - 'SHELL': '/bin/bash', 11:39:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:30 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:30 INFO - 'USER': 'cltbld', 11:39:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:30 INFO - 'XPC_FLAGS': '0x0', 11:39:30 INFO - 'XPC_SERVICE_NAME': '0', 11:39:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39: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 11:39:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:39:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:39:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:39:33 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 11:39:33 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 11:39:33 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 11:39:33 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 11:39:33 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 11:39:33 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 11:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:39:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:39:34 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 11:39:34 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 11:39:34 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 11:39:34 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 11:39:34 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 11:39:34 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 11:39:34 INFO - Downloading docopt-0.6.1.tar.gz 11:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:39:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:39:34 INFO - Running setup.py install for blobuploader 11:39:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:39:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:39:35 INFO - Running setup.py install for requests 11:39:35 INFO - Running setup.py install for docopt 11:39:35 INFO - Successfully installed blobuploader requests docopt 11:39:35 INFO - Cleaning up... 11:39:35 INFO - Return code: 0 11:39:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:35 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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:35 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 11:39:35 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 11:39:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:35 INFO - 'HOME': '/Users/cltbld', 11:39:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:35 INFO - 'LOGNAME': 'cltbld', 11:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:35 INFO - 'MOZ_NO_REMOTE': '1', 11:39:35 INFO - 'NO_EM_RESTART': '1', 11:39:35 INFO - 'PAGER': '/bin/cat', 11:39:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:35 INFO - 'PWD': '/builds/slave/test', 11:39:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:35 INFO - 'SHELL': '/bin/bash', 11:39:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:35 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:35 INFO - 'USER': 'cltbld', 11:39:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:35 INFO - 'XPC_FLAGS': '0x0', 11:39:35 INFO - 'XPC_SERVICE_NAME': '0', 11:39:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-KpzDJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-2S4NJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-BhqmlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-PYYqkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-dgr8Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-EwhteH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-AHQAP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-AcLpPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-IkPXlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:36 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-uxY0cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-dH2ew1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-nGnzJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-dcADoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-zzHO9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-MvDlqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-BaCqRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:37 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-gp5NaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:39:37 INFO - Running setup.py install for manifestparser 11:39:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:39:37 INFO - Running setup.py install for mozcrash 11:39:38 INFO - Running setup.py install for mozdebug 11:39:38 INFO - Running setup.py install for mozdevice 11:39:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Running setup.py install for mozfile 11:39:38 INFO - Running setup.py install for mozhttpd 11:39:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Running setup.py install for mozinfo 11:39:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Running setup.py install for mozInstall 11:39:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:39:38 INFO - Running setup.py install for mozleak 11:39:39 INFO - Running setup.py install for mozlog 11:39:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:39:39 INFO - Running setup.py install for moznetwork 11:39:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:39:39 INFO - Running setup.py install for mozprocess 11:39:39 INFO - Running setup.py install for mozprofile 11:39:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:39:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:39:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:39:39 INFO - Running setup.py install for mozrunner 11:39:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:39:39 INFO - Running setup.py install for mozscreenshot 11:39:40 INFO - Running setup.py install for moztest 11:39:40 INFO - Running setup.py install for mozversion 11:39:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:39:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:39:40 INFO - Cleaning up... 11:39:40 INFO - Return code: 0 11:39:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:40 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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:40 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 11:39:40 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 11:39:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:40 INFO - 'HOME': '/Users/cltbld', 11:39:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:40 INFO - 'LOGNAME': 'cltbld', 11:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:40 INFO - 'MOZ_NO_REMOTE': '1', 11:39:40 INFO - 'NO_EM_RESTART': '1', 11:39:40 INFO - 'PAGER': '/bin/cat', 11:39:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:40 INFO - 'PWD': '/builds/slave/test', 11:39:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:40 INFO - 'SHELL': '/bin/bash', 11:39:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:40 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:40 INFO - 'USER': 'cltbld', 11:39:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:40 INFO - 'XPC_FLAGS': '0x0', 11:39:40 INFO - 'XPC_SERVICE_NAME': '0', 11:39:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:39:40 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-c4M5rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:39:40 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)) 11:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:39:40 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-UYr_Xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:39:40 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)) 11:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:39:40 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-v7NvaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:39:40 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)) 11:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-UCUnJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-OWszfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-X23XdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-zvD89j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-qXf7Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-IOyayJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-_GUhw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-RsOBur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-vFqChs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:39:41 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)) 11:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:39:41 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-TqAjgb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:39:42 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)) 11:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:39:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-EIdLWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:39:42 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)) 11:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-xgxAnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:39:42 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)) 11:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:39:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-fe9d1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:39:42 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)) 11:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:39:42 INFO - Running setup.py (path:/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/pip-XmcGMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:39:42 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)) 11:39:42 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)) 11:39:42 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)) 11:39:42 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)) 11:39:42 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)) 11:39:42 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)) 11:39:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:39:42 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 11:39:42 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 11:39:42 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 11:39:42 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 11:39:42 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 11:39:42 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 11:39:44 INFO - Downloading blessings-1.6.tar.gz 11:39:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:39:45 INFO - Installing collected packages: blessings 11:39:45 INFO - Running setup.py install for blessings 11:39:45 INFO - Successfully installed blessings 11:39:45 INFO - Cleaning up... 11:39:45 INFO - Return code: 0 11:39:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:39:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:45 INFO - Reading from file tmpfile_stdout 11:39:45 INFO - Current package versions: 11:39:45 INFO - blessings == 1.6 11:39:45 INFO - blobuploader == 1.2.4 11:39:45 INFO - docopt == 0.6.1 11:39:45 INFO - functools32 == 3.2.3-2 11:39:45 INFO - jsonschema == 2.5.1 11:39:45 INFO - manifestparser == 1.1 11:39:45 INFO - mozInstall == 1.12 11:39:45 INFO - mozcrash == 0.17 11:39:45 INFO - mozdebug == 0.1 11:39:45 INFO - mozdevice == 0.48 11:39:45 INFO - mozfile == 1.2 11:39:45 INFO - mozhttpd == 0.7 11:39:45 INFO - mozinfo == 0.9 11:39:45 INFO - mozleak == 0.1 11:39:45 INFO - mozlog == 3.4 11:39:45 INFO - moznetwork == 0.27 11:39:45 INFO - mozprocess == 0.23 11:39:45 INFO - mozprofile == 0.28 11:39:45 INFO - mozrunner == 6.12 11:39:45 INFO - mozscreenshot == 0.1 11:39:45 INFO - mozsystemmonitor == 0.3 11:39:45 INFO - moztest == 0.7 11:39:45 INFO - mozversion == 1.4 11:39:45 INFO - psutil == 3.1.1 11:39:45 INFO - requests == 1.2.3 11:39:45 INFO - wsgiref == 0.1.2 11:39:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:39:45 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')]} 11:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:45 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')]} 11:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:45 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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:45 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 11:39:45 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 11:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:45 INFO - 'HOME': '/Users/cltbld', 11:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:45 INFO - 'LOGNAME': 'cltbld', 11:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:45 INFO - 'MOZ_NO_REMOTE': '1', 11:39:45 INFO - 'NO_EM_RESTART': '1', 11:39:45 INFO - 'PAGER': '/bin/cat', 11:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:45 INFO - 'PWD': '/builds/slave/test', 11:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:45 INFO - 'SHELL': '/bin/bash', 11:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:45 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:45 INFO - 'USER': 'cltbld', 11:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:45 INFO - 'XPC_FLAGS': '0x0', 11:39:45 INFO - 'XPC_SERVICE_NAME': '0', 11:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 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)) 11:39:45 INFO - Cleaning up... 11:39:45 INFO - Return code: 0 11:39:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:39:45 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')]} 11:39:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:39:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:45 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')]} 11:39:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:39:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:39:45 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 0x1042cb490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104241570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f2d9bbb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, '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.A9FZl0HjoP/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.hI44BLZRva/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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 11:39:45 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 11:39:45 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 11:39:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:39:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:45 INFO - 'HOME': '/Users/cltbld', 11:39:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:45 INFO - 'LOGNAME': 'cltbld', 11:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:45 INFO - 'MOZ_NO_REMOTE': '1', 11:39:45 INFO - 'NO_EM_RESTART': '1', 11:39:45 INFO - 'PAGER': '/bin/cat', 11:39:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:45 INFO - 'PWD': '/builds/slave/test', 11:39:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:45 INFO - 'SHELL': '/bin/bash', 11:39:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:39:45 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:39:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:45 INFO - 'USER': 'cltbld', 11:39:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:45 INFO - 'XPC_FLAGS': '0x0', 11:39:45 INFO - 'XPC_SERVICE_NAME': '0', 11:39:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:39:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:39:46 INFO - Cleaning up... 11:39:46 INFO - Return code: 0 11:39:46 INFO - Running post-action listener: _resource_record_post_action 11:39:46 INFO - Running post-action listener: _start_resource_monitoring 11:39:46 INFO - Starting resource monitoring. 11:39:46 INFO - [mozharness: 2016-09-23 18:39:46.170332Z] Finished create-virtualenv step (success) 11:39:46 INFO - [mozharness: 2016-09-23 18:39:46.171318Z] Running install step. 11:39:46 INFO - Running pre-action listener: _resource_record_pre_action 11:39:46 INFO - Running main action method: install 11:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:39:46 INFO - Reading from file tmpfile_stdout 11:39:46 INFO - Detecting whether we're running mozinstall >=1.0... 11:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:39:46 INFO - Reading from file tmpfile_stdout 11:39:46 INFO - Output received: 11:39:46 INFO - Usage: mozinstall [options] installer 11:39:46 INFO - Options: 11:39:46 INFO - -h, --help show this help message and exit 11:39:46 INFO - -d DEST, --destination=DEST 11:39:46 INFO - Directory to install application into. [default: 11:39:46 INFO - "/builds/slave/test"] 11:39:46 INFO - --app=APP Application being installed. [default: firefox] 11:39:46 INFO - mkdir: /builds/slave/test/build/application 11:39:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:39:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:40:21 INFO - Reading from file tmpfile_stdout 11:40:21 INFO - Output received: 11:40:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:40:21 INFO - Running post-action listener: _resource_record_post_action 11:40:21 INFO - [mozharness: 2016-09-23 18:40:21.639860Z] Finished install step (success) 11:40:21 INFO - [mozharness: 2016-09-23 18:40:21.639989Z] Running run-tests step. 11:40:21 INFO - Running pre-action listener: _resource_record_pre_action 11:40:21 INFO - Running main action method: run_tests 11:40:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:40:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:40:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:40:21 INFO - 2016-09-23 11:40:21.654 screenresolution[1640:7894] starting screenresolution argv=screenresolution get 11:40:21 INFO - 2016-09-23 11:40:21.656 screenresolution[1640:7894] Display 0: 1600x1200x32@60 11:40:21 INFO - 2016-09-23 11:40:21.663 screenresolution[1641:7897] starting screenresolution argv=screenresolution list 11:40:21 INFO - Available Modes on Display 0 11:40:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:40:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:40:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:40:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:40:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:40:21 INFO - Intel Iris: 11:40:21 INFO - Chipset Model: Intel Iris 11:40:21 INFO - Type: GPU 11:40:21 INFO - Bus: Built-In 11:40:21 INFO - VRAM (Dynamic, Max): 1536 MB 11:40:21 INFO - Vendor: Intel (0x8086) 11:40:21 INFO - Device ID: 0x0a2e 11:40:21 INFO - Revision ID: 0x0009 11:40:21 INFO - Displays: 11:40:21 INFO - Display: 11:40:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:40:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:40:21 INFO - Display Serial Number: 1600x1200 60 11:40:21 INFO - Main Display: Yes 11:40:21 INFO - Mirror: Off 11:40:21 INFO - Online: Yes 11:40:21 INFO - Rotation: Supported 11:40:21 INFO - Return code: 0 11:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:40:21 INFO - Python 2.7.3 11:40:21 INFO - Return code: 0 11:40:21 INFO - grabbing minidump binary from tooltool 11:40:21 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')]} 11:40:21 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 0x1040dfd30>, '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 0x103f05db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1040d7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:40:21 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 11:40:21 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 11:40:21 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 11:40:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:40:22 INFO - Return code: 0 11:40:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:40:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:40:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:40:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:40:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:40:22 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/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 11:40:22 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/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0224 --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 11:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.A9FZl0HjoP/Render', 11:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:40:22 INFO - 'HOME': '/Users/cltbld', 11:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:40:22 INFO - 'LOGNAME': 'cltbld', 11:40:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:40:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:40:22 INFO - 'MOZ_NO_REMOTE': '1', 11:40:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:40:22 INFO - 'NO_EM_RESTART': '1', 11:40:22 INFO - 'PAGER': '/bin/cat', 11:40:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:40:22 INFO - 'PWD': '/builds/slave/test', 11:40:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:40:22 INFO - 'SHELL': '/bin/bash', 11:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hI44BLZRva/Listeners', 11:40:22 INFO - 'TMPDIR': '/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/', 11:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:40:22 INFO - 'USER': 'cltbld', 11:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:40:22 INFO - 'XPC_FLAGS': '0x0', 11:40:22 INFO - 'XPC_SERVICE_NAME': '0', 11:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:40:22 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/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0224', '--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 11:40:22 INFO - mozversion application_buildid: 20160923101725 11:40:22 INFO - mozversion application_changeset: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c 11:40:22 INFO - mozversion application_display_name: Nightly 11:40:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:40:22 INFO - mozversion application_name: Firefox 11:40:22 INFO - mozversion application_remotingname: firefox 11:40:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:40:22 INFO - mozversion application_vendor: Mozilla 11:40:22 INFO - mozversion application_version: 52.0a1 11:40:22 INFO - mozversion platform_buildid: 20160923101725 11:40:22 INFO - mozversion platform_changeset: 76fd7dbb20d5387fe43dd30337b12f8ccb0bd30c 11:40:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:40:22 INFO - mozversion platform_version: 52.0a1 11:40:22 INFO - using testdate: 1474656022 11:40:22 INFO - actual date: 1474656022 11:40:22 INFO - starting webserver on 'localhost:49266' 11:40:22 INFO - SUITE-START | Running 2 tests 11:40:22 INFO - TEST-START | dromaeo_css 11:40:22 INFO - operating with platform_type : mac_ 11:40:22 INFO - Initialising browser for dromaeo_css test... 11:40:22 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpK1e8dy/profile http://localhost:49266/getInfo.html) 11:40:24 INFO - PROCESS | 1651 | 2016-09-23 11:40:24.894 plugin-container[1654:8061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4843, name = 'com.apple.tsm.portname' 11:40:24 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:40:24 INFO - PROCESS | 1651 | 2016-09-23 11:40:24.896 plugin-container[1654:8061] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 11:40:24 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:40:24 INFO - PROCESS | 1651 | 2016-09-23 11:40:24.896 plugin-container[1654:8061] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:40:24 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 11:40:24 INFO - PROCESS | 1651 | colorDepth:24 11:40:24 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 11:40:24 INFO - PROCESS | 1651 | __metrics 11:40:25 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 11:40:25 INFO - TEST-INFO | 1651: exit 0 11:40:25 INFO - Browser initialized. 11:40:25 INFO - Running cycle 1/1 for dromaeo_css test... 11:40:25 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpK1e8dy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:40:28 INFO - PROCESS | 1655 | 2016-09-23 11:40:28.004 plugin-container[1656:8175] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x851f, name = 'com.apple.tsm.portname' 11:40:28 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:40:28 INFO - PROCESS | 1655 | 2016-09-23 11:40:28.007 plugin-container[1656:8175] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 11:40:28 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:40:28 INFO - PROCESS | 1655 | 2016-09-23 11:40:28.007 plugin-container[1656:8175] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:40:37 INFO - PROCESS | 1655 | RSS: Main: 239357952 11:40:37 INFO - PROCESS | 1655 | 11:41:27 INFO - PROCESS | 1655 | 1474656087365 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] 11:43:39 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 11:43:40 INFO - PROCESS | 1655 | RSS: Main: 255545344 11:43:40 INFO - PROCESS | 1655 | 11:46:43 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 11:46:43 INFO - PROCESS | 1655 | RSS: Main: 265486336 11:46:43 INFO - PROCESS | 1655 | 11:49:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 11:49:46 INFO - PROCESS | 1655 | RSS: Main: 269844480 11:49:46 INFO - PROCESS | 1655 | 11:52:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 11:52:48 INFO - PROCESS | 1655 | RSS: Main: 269516800 11:52:48 INFO - PROCESS | 1655 | 11:55:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 11:55:52 INFO - PROCESS | 1655 | RSS: Main: 274952192 11:55:52 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 11:58:55 INFO - PROCESS | 1655 | RSS: Main: 277504000 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | __start_tp_report 11:58:55 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 11:58:55 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 11:58:55 INFO - PROCESS | 1655 | |i|pagename|runs| 11:58:55 INFO - PROCESS | 1655 | |0;dojo.html;2929.6777354491;3386.6444023377544;3397.2186397128658;3423.5207071010045;3443.793372397656;4693.601043911267;5543.833684989457;5739.540836733062;5796.478316951474;5816.272965879265;5645.15322701595;5753.683547404891;5764.9135262970985;5767.942320576793;5779.306483222009;5182.3262975813095;5229.555487783543;5239.13554263546;5308.124159513675;5315.946840531584;5297.258383826267;5309.097453432906;5325.893482130355;5327.600429967749;5346.224797404393;4580.152671755719;5077.213031980031;5281.0758117329315;5311.362636483627;5331.813386531472;5235.842924712265;5292.259083728281;5322.893542129135;5355.732213389315;5372.435894231108;5160.303359046556;5262.631615786897;5269.762860671279;5276.419593844674;5285.127953887604;5514.310711161105;5572.637778544382;5660.490555849993;5730.36965933747;5896.734646940898;5667.801626943078;5810.54736315921;6223.471004964538;6240.843978900519;6247.187865577492;6214.844628884314;6218.036204388327;6218.502519798405;6230.408111229426;6238.126662267241;5776.797812076557;5786.739596718157;5848.67832269225;5874.236349274567;5897.882042359129;6241.531885108635;6250.343713909974;6262.749490020348;6277.05844123376;6284.277308109535;6026.276846778414;6194.938050619436;6198.318184999646;6213.2233470816145;6228.6574238416415;5025.39695236574;6145.40219542922;6171.876562468815;6183.876322473526;6209.59637623553;6211.565190436717;6215.098810672517;6220.253569571681;6228.190335256388;6241.594296370721;5407.134858422633;6079.817605471754;6185.721642526097;6228.532860035515;6237.532185086136;4523.11799199153;4573.199690054227;4793.784279707422;4831.251156070744;4894.363732714795;4191.874243772691;4371.322445020964;4389.297712366006;4414;4461.776911154494;5330.600204984564;5882.558808089325;5908.4091590841435;5911.733971971272;5931.881362372815;4461.57615026572;5009.298698182258;5424.511793938565;5823.505002074787;6184.628922264678;5057.949420505748;5508.44915508446;5899.587028908021;5927.377625349276;5955.166276721263;4523.954760452353;4826.58973987215;5444.91832622511;5468.425815289417;5507.5593952483705;5130.97434512825;5260.289860868734;6198.101275315144;6198.690065496617;6213.875722485615;6161.876762464815;6223.751049957951;6223.844403889939;6225.097360882737;6239.75040998355;6255.437010669061;6339.492840572835;6350.015747559136;6351.491880649444;6375.872482550416;6092.147099406176;6133.754649813957;6141.416565426277;6206.627602343874;6218.9378106220165;5157.561607263425;6140.289530736458;6185.41238582334;6198.194234749634;6220.377962203744;5970.402959704169;6008.699565021819;6090.69546522681;6130.693465326805;6143.1706719592285;5968.239369385955;6058.636481811105;6095.817125486243;6103.694815259308;6142.877142457037;4941.703497790144;5949.732262048132;5959.821205363846;6029.1559181715475;6057.303410107894;6028.608140470856;6081.543884208791;6111.297200821785;6117.418845209698;6137.6931153441255;5784.190213370048;6020.247469066367;6025.427584379477;6035.637861728311;6040.637561746309 11:58:55 INFO - PROCESS | 1655 | |1;ext.html;490.0639778023973;497.30377471539845;513.9229115632655;519.9090159222135;546.6009812836629;32540.67459325406;39884.40173397398;41359.58640413595;41547;41564.16871662569;42611.3608295875;43133.7843310783;43137.78431107848;43148;43193.704188874384;9694.224462043037;9841.901580984206;9880.25898057645;9887;9953.850692239623;9760.755026343944;9764.560594773253;9792.020797920222;9868.555914983843;9877.456739879304;9791.853122203172;9840.16358609519;9863.063009014133;9899.851502227437;9900.90099099007;9817.558209880572;9818.75453113678;9830.311878168532;9846.556904939223;9883.604655813759;9749.658761943369;9792.16766574842;9802.166815820663;9808.362456440309;9851.359661621971;40476;40798.79600602008;40805.59194408048;40894.59105408967;40936;3457.0665920201654;3580.5882323532605;3612.060864175307;3843.942340864889;3872.535295764498;30664.69335306663;30766;30938;31321.06036818899;31925.042248732574;3211.6146062472653;3240.1089700332363;3247.5453436518906;3251.19288193324;3256.153400115963;430769;433067;434622;435812;436619.9999999968;52173.21740173824;52552.47447525552;57428.71285643545;57654;57840.71079644575;30074.849625751733;31290.843545782125;34056.31887362239;35481.29037419237;42708.14583708309;16012.919935400249;16234.350625975065;16365.754513682305;16387.0167789933;16449.25978330978;12488.875111248954;12599.5590154346;12620.495180192689;12658.683532911567;12660.366981651065;16392.75410868838;17188.914055429643;18209.7268540972;18223.362182323555;18521.259149634134;8076.959615201887;8143.75568732939;8233.423660343718;8253.463524870864;8262.876056859152;758.9867526851605;839.4333824668324;932.8880534335788;937.5452905340904;954.5704433005176;23893.641595376084;26008.829602667924;30570;30648.38703225923;32246.516302255484;876.9736907892774;895.4224525181352;927.6057675487891;1065.6217042949797;1110.5502271580024;15005.099694018176;15102.244887755569;15187.924060379628;15417.922910385376;15453.304601292968;533087;586364;588523;594270;599870;46773.766131169126;48922.53232403033;54085.72957135189;54341.72829135908;55282;1281.7820970434861;1337.2177276293478;1393.825771778548;1399.2793711238721;1403.6561042544438;23967.52064958656;26309.21072367832;27887;28449.43528105974;28903;48075;48754.26868596903;48773.512264878314;48911.26633100435;49487;546301;547097;550283;552931;553504;25037.873295702102;25314.493710126062;25507.617385738857;25813.741862581886;25914.740852591985;44714;44858.77570612126;45573.08853822839;45630;45732.59743635827;36701;37333.43999840059;37526.62473375232;38543.614563854004;38575.807120964215;37146.8142659285;37422.06444838901;37501.2499749998;38113.618863811;38215;30735.538966915068;31334.373312533167;34846;36751.632483674824;36958.63041369659;26705.866470667523;33718;33727.49408758822;33797;33958.83020584881;20468;22574.661380078982;25080.874595626905;25430.109946151795;25860.482790344464 11:58:55 INFO - PROCESS | 1655 | |2;jquery.html;344.52799664459695;367.5681074737184;375.401235030127;375.6420539748807;380.07831009801225;15845.524634260977;18787.966661833576;19410.51473713156;20154.89922550389;20911.581768364624;19599.706004409945;20062.297819576317;20063.49841253966;20161;20202.494937626565;4939.678920870141;5734.598578099534;6004.939950600482;6011.669358185298;6028.03551431771;5771.682557459338;5938.792142275021;5946.464818166364;5946.851328716773;5946.970265148668;5553.972230138864;5636.2954630671165;5883.794067207648;5904.468597826195;5908.793192238272;5824.854378640525;5854.4730974212525;5874.23634927461;5875.882482350372;5886.234789477362;4907.607391408679;5087.084324821531;5132.871678208037;5140.691558506502;5160.8967820643375;24559.754402456103;24788.25635230946;24877.751222487906;25093;25107.87446062776;2066.3284432559476;2185.9016344264387;2274.829387795922;2322.5587138443643;2775.3477932686005;9883.456409897453;10182.338148020355;10367.740806479824;10499.107575856062;10514.316569422963;1648.9034791863517;1802.8287312705272;1924.1726057795142;1956.4619729574338;1960.4804726747423;123358.9999999991;125825;126643;128166;128328;11093.83359249612;11474.655760327203;11536.94231528837;11551.595694150665;11628.1860269782;14101.506447274502;14475.710485790225;14486.782698259534;14498.492552760603;14513.492027778977;8267.669293228324;8545.658173673108;8557.400981931329;8558.35812314079;8689.304855611535;8478.576071196416;8515.616797244138;8519.57402129891;8649.956750216208;8735.781605459915;4495.865124046284;4533.410656614685;4577.679562430598;4652.232381656989;4662.906741865144;1915.6590386729345;1959.1673538745977;1969.045013168612;1970.3694817658497;1982.8017198280345;764.7246991083206;835.9373047021497;909.7854364423437;919.8988111307751;924.7872989212519;19639.901800490905;21039.579208416053;21103;21114.683279750818;21284.574308514053;772.3898120484866;922.0871337376084;948.9145976862116;960.490939801906;962.5283611030544;10823.783524329627;11111.27670884439;11251.83122253167;11275.32348059119;11299.49152288149;505074;509807;521307;522575;524514;112119;115062;115607;116152.41923790328;117133;1004.2969921055291;1026.1124127629696;1031.118393773328;1071.5927947379946;1073.581303291717;15396.153211573472;15420.997635153679;17650;18031.459056228334;18936;50950.74524627353;52295.73852130715;52408.47591524036;54427.72786136044;54897.725511373785;76017.23982760323;78263;78486.6075669618;80484.59757701408;80636.7904481445;6169.475594574512;6696.899546506709;6850.349216824394;7379.704811807683;7556.735514256975;9145.63417463294;12585.622431327074;12642.683932901751;12976.675583110498;13036.152650077714;10777.083947864206;11135.665930022113;11307.982281594695;11379.943100284445;11594.304341739522;10004.399736015863;10839.403832789272;10878.891211087788;10957.83563246568;11094.667159985212;11089.778204435705;11339.603113890975;11364.715882103013;11486.712832178928;11521.366324852213;7159.319864613062;7342.48602597813;7377.151627562899;7416.851662966818;7585.279398457138;9342.766430839012;10935.234533582572;11064.612738554111;11074.34215788221;11190.720231994264 11:58:55 INFO - PROCESS | 1655 | |3;mootools.html;1337.973240535189;1499.5801175670813;1697.3550050980625;1844.4282272495518;1896;8179.304759095484;8474.40679152458;8639.784005399868;9232.446053236803;9258.861117083241;8746;9106.362554621179;9106.998230194673;9107.180353768175;9123.863142052875;2391.366287933695;2426.915057972971;2428.0166532554344;2431.468175049716;2432.586460301753;2405.5429468401035;2415.0581273303424;2421.1525965911965;2444.156765915765;2447.3881529617597;2387.570237357275;2411.626197939322;2417.347316224618;2437;2440.2191298784396;2400.975990240093;2410.7227668818045;2416.214730212679;2423.9030438782515;2428.5021570578165;2028.9086991085437;2151.8170955468804;2404.3748625357357;2410.2287268074224;2423.9151629692874;7720.420968427335;8685.826283474358;9075.36472446929;9081.81836363269;9242.584083716181;5328.600354973354;5479.479449452336;5497.092979658351;5521.254630624854;5529.391766905637;3586.3544561978833;3704.5369328833895;3711.962880371189;3750.1562148516364;3776.905577360588;955.5508910811907;1092.3391348234284;1103.6688993301977;1112.671761830254;1116.759896622222;10042.89957100427;11903.821442678367;11990.220635658654;12122.212056216318;12148.696282593006;4403.493598236179;4503.81984720614;4661.3707149534375;4665.113628410591;4668.299755036704;8073.15231900642;9197.172254497127;9303.023182565868;9345.485998270024;9403.952980235055;5244;5319.760610772447;5324.494173053554;5336.62643614951;5339;4478.9552104478535;4626.1441633297945;4804.0872234275375;4937.629677774181;5000.424951130593;3730.8694195703565;3792.4500947362476;3863.16941857502;3882.0488980199466;3933.468981687493;1120.1598800899326;1122.4331712485307;1123.9325640461598;1127.6278827986744;1136.3749937534324;861.4106972635477;861.5132450165762;900.2842740021567;905.9728208153766;940.3981451870808;5742.511886489611;5828.329742079631;6066.726997285133;6095.603785753912;6189.659568723673;787.4291138924234;866.8396346675759;883.8630012348096;920.2270093121809;1011.4588695048261;3953.150072734318;3978.4430179774854;4018.517777866675;4107.609777071173;4112.609302116294;10737.194710396752;11048.171387145996;11120.443977801078;11190.992810647082;11233.269837460703;11150;11150.553977840795;11157.107431405468;11187.160962927814;11190.888091118984;8258.463199891989;8349.33205343571;8352.331813454908;8361.414700970996;8375.874361884577;5752.6836024019085;5901.645901245939;5980.581359304981;6022.3977602241175;6130.080487926846;9893.01069893005;10215.927327630492;10341.172706183337;10361.171106311627;10370.325928814604;10373.533191006272;10482.475876206312;10513.948605139425;10532.789344213226;10545.525451354553;6636.502262330248;6843.349881761224;6940.757073502403;7145.964270178616;7256.564606123649;8338.916610834056;8679.349048821237;8684.565771711515;8688.52213128284;8705.608247628745;7490.213527579525;7693.076830780342;7718.189590092959;7754.224577542201;7764.534127952341;7508;7541.472096953161;7574.810629734301;7588.127365353055;7759.068911730628;7093.32613401726;7112.928870711434;7214.350708436266;7223.674934628059;7228.20489746138;5019.548240658358;5038.294638750504;5122.513361230677;5143.177091665316;5278.261043453843;4322.7190232634775;5090.643654944119;5114.539691427789;5211.530962213419;5257.894842103213 11:58:55 INFO - PROCESS | 1655 | |4;prototype.html;301.14174602383207;303.0318133563265;311.2995759541033;314.7419116324612;314.7969559634036;4300.3764454154125;5349.652272602279;5427.945720542798;5505.807296744615;5512.503874651281;5239.711815850127;5378.220158077076;5432.70120143392;5441.96602645498;5460.235567020621;3571.428571428572;3783.4703141560203;4051.6961227907877;4177.603127702879;4188.97905510472;3972.7616343019367;4023.7988100595;4161.334186530155;4170.97914510427;4176.895577610554;3449.8275086245712;3916.295066887959;4127.688494443107;4130.132672138854;4142.97928510357;4104.753714777123;4134.028503301722;4135.669146468275;4172;4172.979135104305;3617.366960781879;3634.5275114235246;3642.8360723767496;3645.3073915956147;3649.4525821126776;4303.4190384298345;4548.295014272793;5189.221616757479;5214.478552144755;5318.44156363584;4143.627073563363;4506.414166158411;4691.5308469152815;4713.010267843722;4782.617390608743;4590.74750888701;5631.831045068655;5708.1437784332265;5717.599768016241;5760.107183386582;3292.8024318540965;3311.516362727954;3643.9271214575824;3842.077901303695;3872.457855900176;4730.479647238801;4989.750512474362;5209.791608335662;5963.731632076567;6054.212952316215;3942.704297177723;3944.112574670676;3967.742096763759;3972.4041393790585;4011.538673052636;3710.165212827146;3799.7530160540027;4030.5767894371256;4032.395140728914;4032.778197199182;4458.888527786767;4675.0883577702025;4677.204875171161;4693.577578017995;4695.413073365829;4783.569478746929;5286.149847553325;5514.889702205934;5796.420357964254;5805.709714514257;1113.6714669172613;1197.9877003931663;1278.8912942399813;1321.9688642858587;1366.7129902720342;818.8280461103235;883.8024476833926;902.8194361127801;916.7708072981754;920.2775820980498;4622.613216035176;4900.338454308694;5308;5381.54256888161;5401.837944861661;4708.599769019604;5342.866428339323;5503.871706300199;5563.693996830132;5726.9713651431475;5176.870578235575;5369.946300537023;5371.355437347465;5406.459354064641;5412.864678383072;2562.244137979263;2617.6727909011374;2623.790096792252;2626.3302857771146;2633.302174923647;4326.58897404746;4640.095181439654;4699.600533954584;4930.827421040246;4973.950260497349;4201.70588058833;4668.5564871337165;4811.687240329367;4824.396950381202;5087.262346959744;4522.660800439914;4539.931901021488;4978.551930326288;5084.110280700863;5193;4957.553820156203;4969;4974.950250497449;4999.875003124951;5040.722760248075;4131.793410329411;4709.8822529435665;4922.661735675525;5398.676079435247;5838.219343100395;5771.0378471319955;5854.858302630946;6223.688815559294;6235.96882015587;6240.687965601793;3326.3846188455213;3679.988003299114;3814.732968692165;4007.9599204008755;4030.2745505809235;5282.181261904411;5648.802291919763;5813.515272835719;5931.495822855106;6051.5173782421825;4635.51327110662;5625.156226566048;5628.817948230917;5796.681182535001;5821.8459170107335;4610.216263235325;5603.439656034527;5756.453136951983;5777.7977770777825;5823.242978412779;4775.283707443911;5374.328208973879;5644.266245388073;5646.0683987141665;5658.943410565842;4848.442429120555;5516.613837031369;5693.914591281051;5819.156222347651;5828.854278642898;5034.697918124924;5641.774329026957;5662.8301150965535;5715.742791574472;5734.397888221677 11:58:55 INFO - PROCESS | 1655 | |5;yui.html;651.4690527220316;720.8882623193407;786.2059320086711;797.7925739307782;812.0985705866487;15099.471518496855;16286;16296.755548666764;16347.918260408711;16366;14702.264886755645;14751.631209219748;14779.187144707037;14815.92592037041;14840.703185936274;642.8842808294505;680.9795706128799;745.7434223333673;831.5966756123275;852.4331319672441;838.0906716212917;847.9908908399017;852.1393392673383;852.7399143261302;852.9232369086781;897.6005677473527;910.258139616214;913.0823522360018;918.6141820435433;919.2048877720757;760.7257843112764;807.9878801817978;910.0308171797049;910.2263076385086;912.4662072687453;589.7375667827819;645.8772833161685;665.617270069707;669.4878418010226;670.4569298867932;14654.560363189015;14670.339834707356;14861.108333500024;14886.553403397915;14893;14456.015688544507;14471.49349772753;14522.709545809024;14537.491187808482;14933.402663893432;11790.764184716343;11833.439136645022;11889.88110118905;11924.224925379822;12099.818502722379;3779.8866034019024;3819.197968426634;3865.4974853269177;3868.1683438060672;3976.642102210786;115199.42400287944;115944.42027789807;116394.41802791017;117228.41385793102;118168;11083.72290692739;11106.389148596743;11247.493862776031;11329.376884271443;11575.13186511015;22273.888630556743;22559.661605075937;22564.32307030759;22611.095556177897;22669.43326416853;7411.4811963162065;7979.281864632211;8068.636911339004;8135.471194372347;8320.875186872201;4379.824807007684;4504.909901801946;4512.34570987205;4524.25349817283;4533.637309015271;3472.1493234157792;3612.674859262679;3613.8193090345376;3615.385384484644;3919.294526985113;630.5838146823074;719.1980941250573;740.1784019738086;747.2788758847738;749.1422321441919;564.3002676680886;582.6387639663436;601.3175046322368;615.9568830181844;637.9792332268427;9251.537423128817;10358.274920755475;10391.272610917164;10573.154147668321;10946.397948112772;580.4253788749108;584.4360192414341;609.598440700888;615.7383112177307;663.890458074422;4327.307630779061;4714.363560919232;4831.758412079382;4833.96615128911;4851.878703032452;92396.15207695808;95050.5247473772;101423;142705;155301.89396212238;115727.2640910387;127296.36351818181;134298;135356.6464335344;137436;108360.37459438115;110687.23281918016;114670;115022;117520.41239793917;9108.635654573744;9238.639933382907;9275.67535136267;9280.350375473652;9315.377663266177;56379;59202.70398647979;59974;60270;61135.38864611475;75308.46915308425;91853;92290;93742;96628.51685741526;12882.355882205664;13364.732705346034;13415.731685366043;13478.393472293967;13572.253526056162;14789;14884.479043233869;14987.8044522477;15069.171195584348;15089.849101508844;12275.324857132944;13685.45258189701;13803.654908627364;13938.094023888414;14112.506062288181;13747.243901585509;13804;13967.580972570839;13977.231252280815;14192.645183870485;13320;13718;13934.930325348309;13985;14145.929270353583;11369.829452558384;11372;11379.203455758017;11416.429178541206;11550.422478875855;8972.551372431482;9820.214382849212;10911.618093366695;11455.885441145481;11579.768404632028 11:58:55 INFO - PROCESS | 1655 | __end_tp_report 11:58:55 INFO - PROCESS | 1655 | __start_cc_report 11:58:55 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,359 11:58:55 INFO - PROCESS | 1655 | __end_cc_report 11:58:55 INFO - PROCESS | 1655 | __startTimestamp1474657135386__endTimestamp 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | ------- Summary: start ------- 11:58:55 INFO - PROCESS | 1655 | Number of tests: 6 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5661.36 Median:5899.59 stddev:671.24 (11.4%) stddev-sans-first:638.18 11:58:55 INFO - PROCESS | 1655 | Values: 2929.7 3386.6 3397.2 3423.5 3443.8 4693.6 5543.8 5739.5 5796.5 5816.3 5645.2 5753.7 5764.9 5767.9 5779.3 5182.3 5229.6 5239.1 5308.1 5315.9 5297.3 5309.1 5325.9 5327.6 5346.2 4580.2 5077.2 5281.1 5311.4 5331.8 5235.8 5292.3 5322.9 5355.7 5372.4 5160.3 5262.6 5269.8 5276.4 5285.1 5514.3 5572.6 5660.5 5730.4 5896.7 5667.8 5810.5 6223.5 6240.8 6247.2 6214.8 6218.0 6218.5 6230.4 6238.1 5776.8 5786.7 5848.7 5874.2 5897.9 6241.5 6250.3 6262.7 6277.1 6284.3 6026.3 6194.9 6198.3 6213.2 6228.7 5025.4 6145.4 6171.9 6183.9 6209.6 6211.6 6215.1 6220.3 6228.2 6241.6 5407.1 6079.8 6185.7 6228.5 6237.5 4523.1 4573.2 4793.8 4831.3 4894.4 4191.9 4371.3 4389.3 4414.0 4461.8 5330.6 5882.6 5908.4 5911.7 5931.9 4461.6 5009.3 5424.5 5823.5 6184.6 5057.9 5508.4 5899.6 5927.4 5955.2 4524.0 4826.6 5444.9 5468.4 5507.6 5131.0 5260.3 6198.1 6198.7 6213.9 6161.9 6223.8 6223.8 6225.1 6239.8 6255.4 6339.5 6350.0 6351.5 6375.9 6092.1 6133.8 6141.4 6206.6 6218.9 5157.6 6140.3 6185.4 6198.2 6220.4 5970.4 6008.7 6090.7 6130.7 6143.2 5968.2 6058.6 6095.8 6103.7 6142.9 4941.7 5949.7 5959.8 6029.2 6057.3 6028.6 6081.5 6111.3 6117.4 6137.7 5784.2 6020.2 6025.4 6035.6 6040.6 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:64781.47 Median:40850.09 stddev:140267.20 (343.4%) stddev-sans-first:140577.63 11:58:55 INFO - PROCESS | 1655 | Values: 490.1 497.3 513.9 519.9 546.6 32540.7 39884.4 41359.6 41547.0 41564.2 42611.4 43133.8 43137.8 43148.0 43193.7 9694.2 9841.9 9880.3 9887.0 9953.9 9760.8 9764.6 9792.0 9868.6 9877.5 9791.9 9840.2 9863.1 9899.9 9900.9 9817.6 9818.8 9830.3 9846.6 9883.6 9749.7 9792.2 9802.2 9808.4 9851.4 40476.0 40798.8 40805.6 40894.6 40936.0 3457.1 3580.6 3612.1 3843.9 3872.5 30664.7 30766.0 30938.0 31321.1 31925.0 3211.6 3240.1 3247.5 3251.2 3256.2 430769.0 433067.0 434622.0 435812.0 436620.0 52173.2 52552.5 57428.7 57654.0 57840.7 30074.8 31290.8 34056.3 35481.3 42708.1 16012.9 16234.4 16365.8 16387.0 16449.3 12488.9 12599.6 12620.5 12658.7 12660.4 16392.8 17188.9 18209.7 18223.4 18521.3 8077.0 8143.8 8233.4 8253.5 8262.9 759.0 839.4 932.9 937.5 954.6 23893.6 26008.8 30570.0 30648.4 32246.5 877.0 895.4 927.6 1065.6 1110.6 15005.1 15102.2 15187.9 15417.9 15453.3 533087.0 586364.0 588523.0 594270.0 599870.0 46773.8 48922.5 54085.7 54341.7 55282.0 1281.8 1337.2 1393.8 1399.3 1403.7 23967.5 26309.2 27887.0 28449.4 28903.0 48075.0 48754.3 48773.5 48911.3 49487.0 546301.0 547097.0 550283.0 552931.0 553504.0 25037.9 25314.5 25507.6 25813.7 25914.7 44714.0 44858.8 45573.1 45630.0 45732.6 36701.0 37333.4 37526.6 38543.6 38575.8 37146.8 37422.1 37501.2 38113.6 38215.0 30735.5 31334.4 34846.0 36751.6 36958.6 26705.9 33718.0 33727.5 33797.0 33958.8 20468.0 22574.7 25080.9 25430.1 25860.5 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:32476.01 Median:13441.16 stddev:87017.97 (647.4%) stddev-sans-first:87228.64 11:58:55 INFO - PROCESS | 1655 | Values: 344.5 367.6 375.4 375.6 380.1 15845.5 18788.0 19410.5 20154.9 20911.6 19599.7 20062.3 20063.5 20161.0 20202.5 4939.7 5734.6 6004.9 6011.7 6028.0 5771.7 5938.8 5946.5 5946.9 5947.0 5554.0 5636.3 5883.8 5904.5 5908.8 5824.9 5854.5 5874.2 5875.9 5886.2 4907.6 5087.1 5132.9 5140.7 5160.9 24559.8 24788.3 24877.8 25093.0 25107.9 2066.3 2185.9 2274.8 2322.6 2775.3 9883.5 10182.3 10367.7 10499.1 10514.3 1648.9 1802.8 1924.2 1956.5 1960.5 123359.0 125825.0 126643.0 128166.0 128328.0 11093.8 11474.7 11536.9 11551.6 11628.2 14101.5 14475.7 14486.8 14498.5 14513.5 8267.7 8545.7 8557.4 8558.4 8689.3 8478.6 8515.6 8519.6 8650.0 8735.8 4495.9 4533.4 4577.7 4652.2 4662.9 1915.7 1959.2 1969.0 1970.4 1982.8 764.7 835.9 909.8 919.9 924.8 19639.9 21039.6 21103.0 21114.7 21284.6 772.4 922.1 948.9 960.5 962.5 10823.8 11111.3 11251.8 11275.3 11299.5 505074.0 509807.0 521307.0 522575.0 524514.0 112119.0 115062.0 115607.0 116152.4 117133.0 1004.3 1026.1 1031.1 1071.6 1073.6 15396.2 15421.0 17650.0 18031.5 18936.0 50950.7 52295.7 52408.5 54427.7 54897.7 76017.2 78263.0 78486.6 80484.6 80636.8 6169.5 6696.9 6850.3 7379.7 7556.7 9145.6 12585.6 12642.7 12976.7 13036.2 10777.1 11135.7 11308.0 11379.9 11594.3 10004.4 10839.4 10878.9 10957.8 11094.7 11089.8 11339.6 11364.7 11486.7 11521.4 7159.3 7342.5 7377.2 7416.9 7585.3 9342.8 10935.2 11064.6 11074.3 11190.7 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5777.41 Median:5028.92 stddev:3258.79 (64.8%) stddev-sans-first:3250.85 11:58:55 INFO - PROCESS | 1655 | Values: 1338.0 1499.6 1697.4 1844.4 1896.0 8179.3 8474.4 8639.8 9232.4 9258.9 8746.0 9106.4 9107.0 9107.2 9123.9 2391.4 2426.9 2428.0 2431.5 2432.6 2405.5 2415.1 2421.2 2444.2 2447.4 2387.6 2411.6 2417.3 2437.0 2440.2 2401.0 2410.7 2416.2 2423.9 2428.5 2028.9 2151.8 2404.4 2410.2 2423.9 7720.4 8685.8 9075.4 9081.8 9242.6 5328.6 5479.5 5497.1 5521.3 5529.4 3586.4 3704.5 3712.0 3750.2 3776.9 955.6 1092.3 1103.7 1112.7 1116.8 10042.9 11903.8 11990.2 12122.2 12148.7 4403.5 4503.8 4661.4 4665.1 4668.3 8073.2 9197.2 9303.0 9345.5 9404.0 5244.0 5319.8 5324.5 5336.6 5339.0 4479.0 4626.1 4804.1 4937.6 5000.4 3730.9 3792.5 3863.2 3882.0 3933.5 1120.2 1122.4 1123.9 1127.6 1136.4 861.4 861.5 900.3 906.0 940.4 5742.5 5828.3 6066.7 6095.6 6189.7 787.4 866.8 883.9 920.2 1011.5 3953.2 3978.4 4018.5 4107.6 4112.6 10737.2 11048.2 11120.4 11191.0 11233.3 11150.0 11150.6 11157.1 11187.2 11190.9 8258.5 8349.3 8352.3 8361.4 8375.9 5752.7 5901.6 5980.6 6022.4 6130.1 9893.0 10215.9 10341.2 10361.2 10370.3 10373.5 10482.5 10513.9 10532.8 10545.5 6636.5 6843.3 6940.8 7146.0 7256.6 8338.9 8679.3 8684.6 8688.5 8705.6 7490.2 7693.1 7718.2 7754.2 7764.5 7508.0 7541.5 7574.8 7588.1 7759.1 7093.3 7112.9 7214.4 7223.7 7228.2 5019.5 5038.3 5122.5 5143.2 5278.3 4322.7 5090.6 5114.5 5211.5 5257.9 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4461.71 Median:4818.04 stddev:1368.34 (28.4%) stddev-sans-first:1336.07 11:58:55 INFO - PROCESS | 1655 | Values: 301.1 303.0 311.3 314.7 314.8 4300.4 5349.7 5427.9 5505.8 5512.5 5239.7 5378.2 5432.7 5442.0 5460.2 3571.4 3783.5 4051.7 4177.6 4189.0 3972.8 4023.8 4161.3 4171.0 4176.9 3449.8 3916.3 4127.7 4130.1 4143.0 4104.8 4134.0 4135.7 4172.0 4173.0 3617.4 3634.5 3642.8 3645.3 3649.5 4303.4 4548.3 5189.2 5214.5 5318.4 4143.6 4506.4 4691.5 4713.0 4782.6 4590.7 5631.8 5708.1 5717.6 5760.1 3292.8 3311.5 3643.9 3842.1 3872.5 4730.5 4989.8 5209.8 5963.7 6054.2 3942.7 3944.1 3967.7 3972.4 4011.5 3710.2 3799.8 4030.6 4032.4 4032.8 4458.9 4675.1 4677.2 4693.6 4695.4 4783.6 5286.1 5514.9 5796.4 5805.7 1113.7 1198.0 1278.9 1322.0 1366.7 818.8 883.8 902.8 916.8 920.3 4622.6 4900.3 5308.0 5381.5 5401.8 4708.6 5342.9 5503.9 5563.7 5727.0 5176.9 5369.9 5371.4 5406.5 5412.9 2562.2 2617.7 2623.8 2626.3 2633.3 4326.6 4640.1 4699.6 4930.8 4974.0 4201.7 4668.6 4811.7 4824.4 5087.3 4522.7 4539.9 4978.6 5084.1 5193.0 4957.6 4969.0 4975.0 4999.9 5040.7 4131.8 4709.9 4922.7 5398.7 5838.2 5771.0 5854.9 6223.7 6236.0 6240.7 3326.4 3680.0 3814.7 4008.0 4030.3 5282.2 5648.8 5813.5 5931.5 6051.5 4635.5 5625.2 5628.8 5796.7 5821.8 4610.2 5603.4 5756.5 5777.8 5823.2 4775.3 5374.3 5644.3 5646.1 5658.9 4848.4 5516.6 5693.9 5819.2 5828.9 5034.7 5641.8 5662.8 5715.7 5734.4 11:58:55 INFO - PROCESS | 1655 | 11:58:55 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24307.73 Median:3542.41 stddev:37931.04 (1070.8%) stddev-sans-first:37995.86 11:58:55 INFO - PROCESS | 1655 | Values: 651.5 720.9 786.2 797.8 812.1 15099.5 16286.0 16296.8 16347.9 16366.0 14702.3 14751.6 14779.2 14815.9 14840.7 642.9 681.0 745.7 831.6 852.4 838.1 848.0 852.1 852.7 852.9 897.6 910.3 913.1 918.6 919.2 760.7 808.0 910.0 910.2 912.5 589.7 645.9 665.6 669.5 670.5 14654.6 14670.3 14861.1 14886.6 14893.0 14456.0 14471.5 14522.7 14537.5 14933.4 11790.8 11833.4 11889.9 11924.2 12099.8 3779.9 3819.2 3865.5 3868.2 3976.6 115199.4 115944.4 116394.4 117228.4 118168.0 11083.7 11106.4 11247.5 11329.4 11575.1 22273.9 22559.7 22564.3 22611.1 22669.4 7411.5 7979.3 8068.6 8135.5 8320.9 4379.8 4504.9 4512.3 4524.3 4533.6 3472.1 3612.7 3613.8 3615.4 3919.3 630.6 719.2 740.2 747.3 749.1 564.3 582.6 601.3 616.0 638.0 9251.5 10358.3 10391.3 10573.2 10946.4 580.4 584.4 609.6 615.7 663.9 4327.3 4714.4 4831.8 4834.0 4851.9 92396.2 95050.5 101423.0 142705.0 155301.9 115727.3 127296.4 134298.0 135356.6 137436.0 108360.4 110687.2 114670.0 115022.0 117520.4 9108.6 9238.6 9275.7 9280.4 9315.4 56379.0 59202.7 59974.0 60270.0 61135.4 75308.5 91853.0 92290.0 93742.0 96628.5 12882.4 13364.7 13415.7 13478.4 13572.3 14789.0 14884.5 14987.8 15069.2 15089.8 12275.3 13685.5 13803.7 13938.1 14112.5 13747.2 13804.0 13967.6 13977.2 14192.6 13320.0 13718.0 13934.9 13985.0 14145.9 11369.8 11372.0 11379.2 11416.4 11550.4 8972.6 9820.2 10911.6 11455.9 11579.8 11:58:55 INFO - PROCESS | 1655 | -------- Summary: end -------- 11:58:55 INFO - PROCESS | 1655 | 11:58:56 INFO - TEST-INFO | 1655: exit 0 11:58:56 INFO - TEST-OK | dromaeo_css | took 1113794ms 11:58:56 INFO - TEST-START | kraken 11:58:56 INFO - operating with platform_type : mac_ 11:58:56 INFO - Initialising browser for kraken test... 11:58:56 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpmeGHMz/profile http://localhost:49266/getInfo.html) 11:58:58 INFO - PROCESS | 1662 | 2016-09-23 11:58:58.631 plugin-container[1663:10376] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8927, name = 'com.apple.tsm.portname' 11:58:58 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:58:58 INFO - PROCESS | 1662 | 2016-09-23 11:58:58.634 plugin-container[1663:10376] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 11:58:58 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:58:58 INFO - PROCESS | 1662 | 2016-09-23 11:58:58.634 plugin-container[1663:10376] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:58:58 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 11:58:58 INFO - PROCESS | 1662 | colorDepth:24 11:58:58 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 11:58:58 INFO - PROCESS | 1662 | __metrics 11:58:58 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 11:58:59 INFO - TEST-INFO | 1662: exit 0 11:58:59 INFO - Browser initialized. 11:58:59 INFO - Running cycle 1/1 for kraken test... 11:58:59 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/T/tmpmeGHMz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:01 INFO - PROCESS | 1664 | 2016-09-23 11:59:01.895 plugin-container[1665:10487] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8827, name = 'com.apple.tsm.portname' 11:59:01 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:59:01 INFO - PROCESS | 1664 | 2016-09-23 11:59:01.897 plugin-container[1665:10487] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d03, name = 'com.apple.CFPasteboardClient' 11:59:01 INFO - PROCESS | 1664 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:59:01 INFO - PROCESS | 1664 | 2016-09-23 11:59:01.897 plugin-container[1665:10487] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:59:11 INFO - PROCESS | 1664 | RSS: Main: 239616000 11:59:11 INFO - PROCESS | 1664 | 11:59:14 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 11:59:15 INFO - PROCESS | 1664 | RSS: Main: 253288448 11:59:15 INFO - PROCESS | 1664 | 11:59:18 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 11:59:18 INFO - PROCESS | 1664 | RSS: Main: 260919296 11:59:18 INFO - PROCESS | 1664 | 11:59:22 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 11:59:22 INFO - PROCESS | 1664 | RSS: Main: 261824512 11:59:22 INFO - PROCESS | 1664 | 11:59:24 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 11:59:25 INFO - PROCESS | 1664 | RSS: Main: 264028160 11:59:25 INFO - PROCESS | 1664 | 11:59:27 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:59:28 INFO - PROCESS | 1664 | RSS: Main: 264568832 11:59:28 INFO - PROCESS | 1664 | 11:59:31 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 11:59:31 INFO - PROCESS | 1664 | RSS: Main: 264896512 11:59:31 INFO - PROCESS | 1664 | 11:59:34 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 11:59:35 INFO - PROCESS | 1664 | RSS: Main: 265064448 11:59:35 INFO - PROCESS | 1664 | 11:59:38 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 11:59:38 INFO - PROCESS | 1664 | RSS: Main: 265285632 11:59:38 INFO - PROCESS | 1664 | 11:59:40 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:59:41 INFO - PROCESS | 1664 | RSS: Main: 265035776 11:59:41 INFO - PROCESS | 1664 | 11:59:43 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:59:43 INFO - PROCESS | 1664 | RSS: Main: 265093120 11:59:43 INFO - PROCESS | 1664 | 11:59:45 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:59:46 INFO - PROCESS | 1664 | RSS: Main: 265121792 11:59:46 INFO - PROCESS | 1664 | 11:59:49 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:59:50 INFO - PROCESS | 1664 | RSS: Main: 265441280 11:59:50 INFO - PROCESS | 1664 | 11:59:53 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:59:53 INFO - PROCESS | 1664 | RSS: Main: 265515008 11:59:53 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 11:59:55 INFO - PROCESS | 1664 | RSS: Main: 266833920 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | __start_tp_report 11:59:55 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 11:59:55 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 11:59:55 INFO - PROCESS | 1664 | |i|pagename|runs| 11:59:55 INFO - PROCESS | 1664 | |0;ai-astar;115;119;117;131;175;164;118;118;123;118 11:59:55 INFO - PROCESS | 1664 | |1;audio-beat-detection;152;110;111;140;141;149;139;93;169;144 11:59:55 INFO - PROCESS | 1664 | |2;audio-dft;205;248;234;246;195;194;193;200;192;198 11:59:55 INFO - PROCESS | 1664 | |3;audio-fft;78;59;60;82;84;82;51;68;105;85 11:59:55 INFO - PROCESS | 1664 | |4;audio-oscillator;82;71;91;96;96;99;99;70;70;86 11:59:55 INFO - PROCESS | 1664 | |5;imaging-gaussian-blur;88;86;89;86;93;86;83;131;135;85 11:59:55 INFO - PROCESS | 1664 | |6;imaging-darkroom;115;125;95;95;94;96;95;96;95;95 11:59:55 INFO - PROCESS | 1664 | |7;imaging-desaturate;96;95;113;113;126;121;143;134;91;125 11:59:55 INFO - PROCESS | 1664 | |8;json-parse-financial;56;58;56;57;56;59;57;58;56;55 11:59:55 INFO - PROCESS | 1664 | |9;json-stringify-tinderbox;76;106;110;84;74;69;68;69;68;72 11:59:55 INFO - PROCESS | 1664 | |10;stanford-crypto-aes;77;93;109;109;104;88;87;87;90;92 11:59:55 INFO - PROCESS | 1664 | |11;stanford-crypto-ccm;141;136;142;137;154;150;154;150;172;141 11:59:55 INFO - PROCESS | 1664 | |12;stanford-crypto-pbkdf2;178;172;232;185;174;171;170;172;171;187 11:59:55 INFO - PROCESS | 1664 | |13;stanford-crypto-sha256-iterative;71;67;69;67;71;68;69;68;67;67 11:59:55 INFO - PROCESS | 1664 | __end_tp_report 11:59:55 INFO - PROCESS | 1664 | __start_cc_report 11:59:55 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,922 11:59:55 INFO - PROCESS | 1664 | __end_cc_report 11:59:55 INFO - PROCESS | 1664 | __startTimestamp1474657195726__endTimestamp 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | ------- Summary: start ------- 11:59:55 INFO - PROCESS | 1664 | Number of tests: 14 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#0] ai-astar Cycles:10 Average:129.80 Median:121.00 stddev:21.54 (17.8%) stddev-sans-first:22.18 11:59:55 INFO - PROCESS | 1664 | Values: 115.0 119.0 117.0 131.0 175.0 164.0 118.0 118.0 123.0 118.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#1] audio-beat-detection Cycles:10 Average:134.80 Median:146.50 stddev:23.01 (15.7%) stddev-sans-first:23.54 11:59:55 INFO - PROCESS | 1664 | Values: 152.0 110.0 111.0 140.0 141.0 149.0 139.0 93.0 169.0 144.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#2] audio-dft Cycles:10 Average:210.50 Median:202.50 stddev:22.79 (11.3%) stddev-sans-first:24.09 11:59:55 INFO - PROCESS | 1664 | Values: 205.0 248.0 234.0 246.0 195.0 194.0 193.0 200.0 192.0 198.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#3] audio-fft Cycles:10 Average:75.40 Median:80.00 stddev:15.96 (19.9%) stddev-sans-first:16.90 11:59:55 INFO - PROCESS | 1664 | Values: 78.0 59.0 60.0 82.0 84.0 82.0 51.0 68.0 105.0 85.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#4] audio-oscillator Cycles:10 Average:86.00 Median:93.50 stddev:12.09 (12.9%) stddev-sans-first:12.74 11:59:55 INFO - PROCESS | 1664 | Values: 82.0 71.0 91.0 96.0 96.0 99.0 99.0 70.0 70.0 86.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#5] imaging-gaussian-blur Cycles:10 Average:96.20 Median:86.00 stddev:19.60 (22.8%) stddev-sans-first:20.56 11:59:55 INFO - PROCESS | 1664 | Values: 88.0 86.0 89.0 86.0 93.0 86.0 83.0 131.0 135.0 85.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#6] imaging-darkroom Cycles:10 Average:100.10 Median:95.00 stddev:10.76 (11.3%) stddev-sans-first:9.98 11:59:55 INFO - PROCESS | 1664 | Values: 115.0 125.0 95.0 95.0 94.0 96.0 95.0 96.0 95.0 95.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#7] imaging-desaturate Cycles:10 Average:115.70 Median:138.50 stddev:17.46 (12.6%) stddev-sans-first:17.00 11:59:55 INFO - PROCESS | 1664 | Values: 96.0 95.0 113.0 113.0 126.0 121.0 143.0 134.0 91.0 125.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.23 (2.2%) stddev-sans-first:1.27 11:59:55 INFO - PROCESS | 1664 | Values: 56.0 58.0 56.0 57.0 56.0 59.0 57.0 58.0 56.0 55.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#9] json-stringify-tinderbox Cycles:10 Average:79.60 Median:70.50 stddev:15.76 (22.4%) stddev-sans-first:16.67 11:59:55 INFO - PROCESS | 1664 | Values: 76.0 106.0 110.0 84.0 74.0 69.0 68.0 69.0 68.0 72.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:87.50 stddev:10.50 (12.0%) stddev-sans-first:9.26 11:59:55 INFO - PROCESS | 1664 | Values: 77.0 93.0 109.0 109.0 104.0 88.0 87.0 87.0 90.0 92.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:150.00 stddev:10.82 (7.2%) stddev-sans-first:11.20 11:59:55 INFO - PROCESS | 1664 | Values: 141.0 136.0 142.0 137.0 154.0 150.0 154.0 150.0 172.0 141.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.20 Median:176.00 stddev:18.84 (10.7%) stddev-sans-first:19.94 11:59:55 INFO - PROCESS | 1664 | Values: 178.0 172.0 232.0 185.0 174.0 171.0 170.0 172.0 171.0 187.0 11:59:55 INFO - PROCESS | 1664 | 11:59:55 INFO - PROCESS | 1664 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.58 (2.3%) stddev-sans-first:1.36 11:59:55 INFO - PROCESS | 1664 | Values: 71.0 67.0 69.0 67.0 71.0 68.0 69.0 68.0 67.0 67.0 11:59:55 INFO - PROCESS | 1664 | -------- Summary: end -------- 11:59:55 INFO - PROCESS | 1664 | 11:59:56 INFO - TEST-INFO | 1664: exit 0 11:59:56 INFO - TEST-OK | kraken | took 60552ms 11:59:56 INFO - SUITE-END | took 1174s 11:59:56 INFO - Completed test suite (00:19:34) 11:59:56 INFO - javascript benchmark 11:59:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7265.737335912785, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2929.6777354491, 3386.6444023377544, 3397.2186397128658, 3423.5207071010045, 3443.793372397656, 4693.601043911267, 5543.833684989457, 5739.540836733062, 5796.478316951474, 5816.272965879265, 5645.15322701595, 5753.683547404891, 5764.9135262970985, 5767.942320576793, 5779.306483222009, 5182.3262975813095, 5229.555487783543, 5239.13554263546, 5308.124159513675, 5315.946840531584, 5297.258383826267, 5309.097453432906, 5325.893482130355, 5327.600429967749, 5346.224797404393, 4580.152671755719, 5077.213031980031, 5281.0758117329315, 5311.362636483627, 5331.813386531472, 5235.842924712265, 5292.259083728281, 5322.893542129135, 5355.732213389315, 5372.435894231108, 5160.303359046556, 5262.631615786897, 5269.762860671279, 5276.419593844674, 5285.127953887604, 5514.310711161105, 5572.637778544382, 5660.490555849993, 5730.36965933747, 5896.734646940898, 5667.801626943078, 5810.54736315921, 6223.471004964538, 6240.843978900519, 6247.187865577492, 6214.844628884314, 6218.036204388327, 6218.502519798405, 6230.408111229426, 6238.126662267241, 5776.797812076557, 5786.739596718157, 5848.67832269225, 5874.236349274567, 5897.882042359129, 6241.531885108635, 6250.343713909974, 6262.749490020348, 6277.05844123376, 6284.277308109535, 6026.276846778414, 6194.938050619436, 6198.318184999646, 6213.2233470816145, 6228.6574238416415, 5025.39695236574, 6145.40219542922, 6171.876562468815, 6183.876322473526, 6209.59637623553, 6211.565190436717, 6215.098810672517, 6220.253569571681, 6228.190335256388, 6241.594296370721, 5407.134858422633, 6079.817605471754, 6185.721642526097, 6228.532860035515, 6237.532185086136, 4523.11799199153, 4573.199690054227, 4793.784279707422, 4831.251156070744, 4894.363732714795, 4191.874243772691, 4371.322445020964, 4389.297712366006, 4414.0, 4461.776911154494, 5330.600204984564, 5882.558808089325, 5908.4091590841435, 5911.733971971272, 5931.881362372815, 4461.57615026572, 5009.298698182258, 5424.511793938565, 5823.505002074787, 6184.628922264678, 5057.949420505748, 5508.44915508446, 5899.587028908021, 5927.377625349276, 5955.166276721263, 4523.954760452353, 4826.58973987215, 5444.91832622511, 5468.425815289417, 5507.5593952483705, 5130.97434512825, 5260.289860868734, 6198.101275315144, 6198.690065496617, 6213.875722485615, 6161.876762464815, 6223.751049957951, 6223.844403889939, 6225.097360882737, 6239.75040998355, 6255.437010669061, 6339.492840572835, 6350.015747559136, 6351.491880649444, 6375.872482550416, 6092.147099406176, 6133.754649813957, 6141.416565426277, 6206.627602343874, 6218.9378106220165, 5157.561607263425, 6140.289530736458, 6185.41238582334, 6198.194234749634, 6220.377962203744, 5970.402959704169, 6008.699565021819, 6090.69546522681, 6130.693465326805, 6143.1706719592285, 5968.239369385955, 6058.636481811105, 6095.817125486243, 6103.694815259308, 6142.877142457037, 4941.703497790144, 5949.732262048132, 5959.821205363846, 6029.1559181715475, 6057.303410107894, 6028.608140470856, 6081.543884208791, 6111.297200821785, 6117.418845209698, 6137.6931153441255, 5784.190213370048, 6020.247469066367, 6025.427584379477, 6035.637861728311, 6040.637561746309], "value": 5620.705164569723, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.0639778023973, 497.30377471539845, 513.9229115632655, 519.9090159222135, 546.6009812836629, 32540.67459325406, 39884.40173397398, 41359.58640413595, 41547.0, 41564.16871662569, 42611.3608295875, 43133.7843310783, 43137.78431107848, 43148.0, 43193.704188874384, 9694.224462043037, 9841.901580984206, 9880.25898057645, 9887.0, 9953.850692239623, 9760.755026343944, 9764.560594773253, 9792.020797920222, 9868.555914983843, 9877.456739879304, 9791.853122203172, 9840.16358609519, 9863.063009014133, 9899.851502227437, 9900.90099099007, 9817.558209880572, 9818.75453113678, 9830.311878168532, 9846.556904939223, 9883.604655813759, 9749.658761943369, 9792.16766574842, 9802.166815820663, 9808.362456440309, 9851.359661621971, 40476.0, 40798.79600602008, 40805.59194408048, 40894.59105408967, 40936.0, 3457.0665920201654, 3580.5882323532605, 3612.060864175307, 3843.942340864889, 3872.535295764498, 30664.69335306663, 30766.0, 30938.0, 31321.06036818899, 31925.042248732574, 3211.6146062472653, 3240.1089700332363, 3247.5453436518906, 3251.19288193324, 3256.153400115963, 430769.0, 433067.0, 434622.0, 435812.0, 436619.9999999968, 52173.21740173824, 52552.47447525552, 57428.71285643545, 57654.0, 57840.71079644575, 30074.849625751733, 31290.843545782125, 34056.31887362239, 35481.29037419237, 42708.14583708309, 16012.919935400249, 16234.350625975065, 16365.754513682305, 16387.0167789933, 16449.25978330978, 12488.875111248954, 12599.5590154346, 12620.495180192689, 12658.683532911567, 12660.366981651065, 16392.75410868838, 17188.914055429643, 18209.7268540972, 18223.362182323555, 18521.259149634134, 8076.959615201887, 8143.75568732939, 8233.423660343718, 8253.463524870864, 8262.876056859152, 758.9867526851605, 839.4333824668324, 932.8880534335788, 937.5452905340904, 954.5704433005176, 23893.641595376084, 26008.829602667924, 30570.0, 30648.38703225923, 32246.516302255484, 876.9736907892774, 895.4224525181352, 927.6057675487891, 1065.6217042949797, 1110.5502271580024, 15005.099694018176, 15102.244887755569, 15187.924060379628, 15417.922910385376, 15453.304601292968, 533087.0, 586364.0, 588523.0, 594270.0, 599870.0, 46773.766131169126, 48922.53232403033, 54085.72957135189, 54341.72829135908, 55282.0, 1281.7820970434861, 1337.2177276293478, 1393.825771778548, 1399.2793711238721, 1403.6561042544438, 23967.52064958656, 26309.21072367832, 27887.0, 28449.43528105974, 28903.0, 48075.0, 48754.26868596903, 48773.512264878314, 48911.26633100435, 49487.0, 546301.0, 547097.0, 550283.0, 552931.0, 553504.0, 25037.873295702102, 25314.493710126062, 25507.617385738857, 25813.741862581886, 25914.740852591985, 44714.0, 44858.77570612126, 45573.08853822839, 45630.0, 45732.59743635827, 36701.0, 37333.43999840059, 37526.62473375232, 38543.614563854004, 38575.807120964215, 37146.8142659285, 37422.06444838901, 37501.2499749998, 38113.618863811, 38215.0, 30735.538966915068, 31334.373312533167, 34846.0, 36751.632483674824, 36958.63041369659, 26705.866470667523, 33718.0, 33727.49408758822, 33797.0, 33958.83020584881, 20468.0, 22574.661380078982, 25080.874595626905, 25430.109946151795, 25860.482790344464], "value": 19164.729626936944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.52799664459695, 367.5681074737184, 375.401235030127, 375.6420539748807, 380.07831009801225, 15845.524634260977, 18787.966661833576, 19410.51473713156, 20154.89922550389, 20911.581768364624, 19599.706004409945, 20062.297819576317, 20063.49841253966, 20161.0, 20202.494937626565, 4939.678920870141, 5734.598578099534, 6004.939950600482, 6011.669358185298, 6028.03551431771, 5771.682557459338, 5938.792142275021, 5946.464818166364, 5946.851328716773, 5946.970265148668, 5553.972230138864, 5636.2954630671165, 5883.794067207648, 5904.468597826195, 5908.793192238272, 5824.854378640525, 5854.4730974212525, 5874.23634927461, 5875.882482350372, 5886.234789477362, 4907.607391408679, 5087.084324821531, 5132.871678208037, 5140.691558506502, 5160.8967820643375, 24559.754402456103, 24788.25635230946, 24877.751222487906, 25093.0, 25107.87446062776, 2066.3284432559476, 2185.9016344264387, 2274.829387795922, 2322.5587138443643, 2775.3477932686005, 9883.456409897453, 10182.338148020355, 10367.740806479824, 10499.107575856062, 10514.316569422963, 1648.9034791863517, 1802.8287312705272, 1924.1726057795142, 1956.4619729574338, 1960.4804726747423, 123358.9999999991, 125825.0, 126643.0, 128166.0, 128328.0, 11093.83359249612, 11474.655760327203, 11536.94231528837, 11551.595694150665, 11628.1860269782, 14101.506447274502, 14475.710485790225, 14486.782698259534, 14498.492552760603, 14513.492027778977, 8267.669293228324, 8545.658173673108, 8557.400981931329, 8558.35812314079, 8689.304855611535, 8478.576071196416, 8515.616797244138, 8519.57402129891, 8649.956750216208, 8735.781605459915, 4495.865124046284, 4533.410656614685, 4577.679562430598, 4652.232381656989, 4662.906741865144, 1915.6590386729345, 1959.1673538745977, 1969.045013168612, 1970.3694817658497, 1982.8017198280345, 764.7246991083206, 835.9373047021497, 909.7854364423437, 919.8988111307751, 924.7872989212519, 19639.901800490905, 21039.579208416053, 21103.0, 21114.683279750818, 21284.574308514053, 772.3898120484866, 922.0871337376084, 948.9145976862116, 960.490939801906, 962.5283611030544, 10823.783524329627, 11111.27670884439, 11251.83122253167, 11275.32348059119, 11299.49152288149, 505074.0, 509807.0, 521307.0, 522575.0, 524514.0, 112119.0, 115062.0, 115607.0, 116152.41923790328, 117133.0, 1004.2969921055291, 1026.1124127629696, 1031.118393773328, 1071.5927947379946, 1073.581303291717, 15396.153211573472, 15420.997635153679, 17650.0, 18031.459056228334, 18936.0, 50950.74524627353, 52295.73852130715, 52408.47591524036, 54427.72786136044, 54897.725511373785, 76017.23982760323, 78263.0, 78486.6075669618, 80484.59757701408, 80636.7904481445, 6169.475594574512, 6696.899546506709, 6850.349216824394, 7379.704811807683, 7556.735514256975, 9145.63417463294, 12585.622431327074, 12642.683932901751, 12976.675583110498, 13036.152650077714, 10777.083947864206, 11135.665930022113, 11307.982281594695, 11379.943100284445, 11594.304341739522, 10004.399736015863, 10839.403832789272, 10878.891211087788, 10957.83563246568, 11094.667159985212, 11089.778204435705, 11339.603113890975, 11364.715882103013, 11486.712832178928, 11521.366324852213, 7159.319864613062, 7342.48602597813, 7377.151627562899, 7416.851662966818, 7585.279398457138, 9342.766430839012, 10935.234533582572, 11064.612738554111, 11074.34215788221, 11190.720231994264], "value": 9362.04115767244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.973240535189, 1499.5801175670813, 1697.3550050980625, 1844.4282272495518, 1896.0, 8179.304759095484, 8474.40679152458, 8639.784005399868, 9232.446053236803, 9258.861117083241, 8746.0, 9106.362554621179, 9106.998230194673, 9107.180353768175, 9123.863142052875, 2391.366287933695, 2426.915057972971, 2428.0166532554344, 2431.468175049716, 2432.586460301753, 2405.5429468401035, 2415.0581273303424, 2421.1525965911965, 2444.156765915765, 2447.3881529617597, 2387.570237357275, 2411.626197939322, 2417.347316224618, 2437.0, 2440.2191298784396, 2400.975990240093, 2410.7227668818045, 2416.214730212679, 2423.9030438782515, 2428.5021570578165, 2028.9086991085437, 2151.8170955468804, 2404.3748625357357, 2410.2287268074224, 2423.9151629692874, 7720.420968427335, 8685.826283474358, 9075.36472446929, 9081.81836363269, 9242.584083716181, 5328.600354973354, 5479.479449452336, 5497.092979658351, 5521.254630624854, 5529.391766905637, 3586.3544561978833, 3704.5369328833895, 3711.962880371189, 3750.1562148516364, 3776.905577360588, 955.5508910811907, 1092.3391348234284, 1103.6688993301977, 1112.671761830254, 1116.759896622222, 10042.89957100427, 11903.821442678367, 11990.220635658654, 12122.212056216318, 12148.696282593006, 4403.493598236179, 4503.81984720614, 4661.3707149534375, 4665.113628410591, 4668.299755036704, 8073.15231900642, 9197.172254497127, 9303.023182565868, 9345.485998270024, 9403.952980235055, 5244.0, 5319.760610772447, 5324.494173053554, 5336.62643614951, 5339.0, 4478.9552104478535, 4626.1441633297945, 4804.0872234275375, 4937.629677774181, 5000.424951130593, 3730.8694195703565, 3792.4500947362476, 3863.16941857502, 3882.0488980199466, 3933.468981687493, 1120.1598800899326, 1122.4331712485307, 1123.9325640461598, 1127.6278827986744, 1136.3749937534324, 861.4106972635477, 861.5132450165762, 900.2842740021567, 905.9728208153766, 940.3981451870808, 5742.511886489611, 5828.329742079631, 6066.726997285133, 6095.603785753912, 6189.659568723673, 787.4291138924234, 866.8396346675759, 883.8630012348096, 920.2270093121809, 1011.4588695048261, 3953.150072734318, 3978.4430179774854, 4018.517777866675, 4107.609777071173, 4112.609302116294, 10737.194710396752, 11048.171387145996, 11120.443977801078, 11190.992810647082, 11233.269837460703, 11150.0, 11150.553977840795, 11157.107431405468, 11187.160962927814, 11190.888091118984, 8258.463199891989, 8349.33205343571, 8352.331813454908, 8361.414700970996, 8375.874361884577, 5752.6836024019085, 5901.645901245939, 5980.581359304981, 6022.3977602241175, 6130.080487926846, 9893.01069893005, 10215.927327630492, 10341.172706183337, 10361.171106311627, 10370.325928814604, 10373.533191006272, 10482.475876206312, 10513.948605139425, 10532.789344213226, 10545.525451354553, 6636.502262330248, 6843.349881761224, 6940.757073502403, 7145.964270178616, 7256.564606123649, 8338.916610834056, 8679.349048821237, 8684.565771711515, 8688.52213128284, 8705.608247628745, 7490.213527579525, 7693.076830780342, 7718.189590092959, 7754.224577542201, 7764.534127952341, 7508.0, 7541.472096953161, 7574.810629734301, 7588.127365353055, 7759.068911730628, 7093.32613401726, 7112.928870711434, 7214.350708436266, 7223.674934628059, 7228.20489746138, 5019.548240658358, 5038.294638750504, 5122.513361230677, 5143.177091665316, 5278.261043453843, 4322.7190232634775, 5090.643654944119, 5114.539691427789, 5211.530962213419, 5257.894842103213], "value": 4621.27881186307, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.14174602383207, 303.0318133563265, 311.2995759541033, 314.7419116324612, 314.7969559634036, 4300.3764454154125, 5349.652272602279, 5427.945720542798, 5505.807296744615, 5512.503874651281, 5239.711815850127, 5378.220158077076, 5432.70120143392, 5441.96602645498, 5460.235567020621, 3571.428571428572, 3783.4703141560203, 4051.6961227907877, 4177.603127702879, 4188.97905510472, 3972.7616343019367, 4023.7988100595, 4161.334186530155, 4170.97914510427, 4176.895577610554, 3449.8275086245712, 3916.295066887959, 4127.688494443107, 4130.132672138854, 4142.97928510357, 4104.753714777123, 4134.028503301722, 4135.669146468275, 4172.0, 4172.979135104305, 3617.366960781879, 3634.5275114235246, 3642.8360723767496, 3645.3073915956147, 3649.4525821126776, 4303.4190384298345, 4548.295014272793, 5189.221616757479, 5214.478552144755, 5318.44156363584, 4143.627073563363, 4506.414166158411, 4691.5308469152815, 4713.010267843722, 4782.617390608743, 4590.74750888701, 5631.831045068655, 5708.1437784332265, 5717.599768016241, 5760.107183386582, 3292.8024318540965, 3311.516362727954, 3643.9271214575824, 3842.077901303695, 3872.457855900176, 4730.479647238801, 4989.750512474362, 5209.791608335662, 5963.731632076567, 6054.212952316215, 3942.704297177723, 3944.112574670676, 3967.742096763759, 3972.4041393790585, 4011.538673052636, 3710.165212827146, 3799.7530160540027, 4030.5767894371256, 4032.395140728914, 4032.778197199182, 4458.888527786767, 4675.0883577702025, 4677.204875171161, 4693.577578017995, 4695.413073365829, 4783.569478746929, 5286.149847553325, 5514.889702205934, 5796.420357964254, 5805.709714514257, 1113.6714669172613, 1197.9877003931663, 1278.8912942399813, 1321.9688642858587, 1366.7129902720342, 818.8280461103235, 883.8024476833926, 902.8194361127801, 916.7708072981754, 920.2775820980498, 4622.613216035176, 4900.338454308694, 5308.0, 5381.54256888161, 5401.837944861661, 4708.599769019604, 5342.866428339323, 5503.871706300199, 5563.693996830132, 5726.9713651431475, 5176.870578235575, 5369.946300537023, 5371.355437347465, 5406.459354064641, 5412.864678383072, 2562.244137979263, 2617.6727909011374, 2623.790096792252, 2626.3302857771146, 2633.302174923647, 4326.58897404746, 4640.095181439654, 4699.600533954584, 4930.827421040246, 4973.950260497349, 4201.70588058833, 4668.5564871337165, 4811.687240329367, 4824.396950381202, 5087.262346959744, 4522.660800439914, 4539.931901021488, 4978.551930326288, 5084.110280700863, 5193.0, 4957.553820156203, 4969.0, 4974.950250497449, 4999.875003124951, 5040.722760248075, 4131.793410329411, 4709.8822529435665, 4922.661735675525, 5398.676079435247, 5838.219343100395, 5771.0378471319955, 5854.858302630946, 6223.688815559294, 6235.96882015587, 6240.687965601793, 3326.3846188455213, 3679.988003299114, 3814.732968692165, 4007.9599204008755, 4030.2745505809235, 5282.181261904411, 5648.802291919763, 5813.515272835719, 5931.495822855106, 6051.5173782421825, 4635.51327110662, 5625.156226566048, 5628.817948230917, 5796.681182535001, 5821.8459170107335, 4610.216263235325, 5603.439656034527, 5756.453136951983, 5777.7977770777825, 5823.242978412779, 4775.283707443911, 5374.328208973879, 5644.266245388073, 5646.0683987141665, 5658.943410565842, 4848.442429120555, 5516.613837031369, 5693.914591281051, 5819.156222347651, 5828.854278642898, 5034.697918124924, 5641.774329026957, 5662.8301150965535, 5715.742791574472, 5734.397888221677], "value": 4028.0507977905595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.4690527220316, 720.8882623193407, 786.2059320086711, 797.7925739307782, 812.0985705866487, 15099.471518496855, 16286.0, 16296.755548666764, 16347.918260408711, 16366.0, 14702.264886755645, 14751.631209219748, 14779.187144707037, 14815.92592037041, 14840.703185936274, 642.8842808294505, 680.9795706128799, 745.7434223333673, 831.5966756123275, 852.4331319672441, 838.0906716212917, 847.9908908399017, 852.1393392673383, 852.7399143261302, 852.9232369086781, 897.6005677473527, 910.258139616214, 913.0823522360018, 918.6141820435433, 919.2048877720757, 760.7257843112764, 807.9878801817978, 910.0308171797049, 910.2263076385086, 912.4662072687453, 589.7375667827819, 645.8772833161685, 665.617270069707, 669.4878418010226, 670.4569298867932, 14654.560363189015, 14670.339834707356, 14861.108333500024, 14886.553403397915, 14893.0, 14456.015688544507, 14471.49349772753, 14522.709545809024, 14537.491187808482, 14933.402663893432, 11790.764184716343, 11833.439136645022, 11889.88110118905, 11924.224925379822, 12099.818502722379, 3779.8866034019024, 3819.197968426634, 3865.4974853269177, 3868.1683438060672, 3976.642102210786, 115199.42400287944, 115944.42027789807, 116394.41802791017, 117228.41385793102, 118168.0, 11083.72290692739, 11106.389148596743, 11247.493862776031, 11329.376884271443, 11575.13186511015, 22273.888630556743, 22559.661605075937, 22564.32307030759, 22611.095556177897, 22669.43326416853, 7411.4811963162065, 7979.281864632211, 8068.636911339004, 8135.471194372347, 8320.875186872201, 4379.824807007684, 4504.909901801946, 4512.34570987205, 4524.25349817283, 4533.637309015271, 3472.1493234157792, 3612.674859262679, 3613.8193090345376, 3615.385384484644, 3919.294526985113, 630.5838146823074, 719.1980941250573, 740.1784019738086, 747.2788758847738, 749.1422321441919, 564.3002676680886, 582.6387639663436, 601.3175046322368, 615.9568830181844, 637.9792332268427, 9251.537423128817, 10358.274920755475, 10391.272610917164, 10573.154147668321, 10946.397948112772, 580.4253788749108, 584.4360192414341, 609.598440700888, 615.7383112177307, 663.890458074422, 4327.307630779061, 4714.363560919232, 4831.758412079382, 4833.96615128911, 4851.878703032452, 92396.15207695808, 95050.5247473772, 101423.0, 142705.0, 155301.89396212238, 115727.2640910387, 127296.36351818181, 134298.0, 135356.6464335344, 137436.0, 108360.37459438115, 110687.23281918016, 114670.0, 115022.0, 117520.41239793917, 9108.635654573744, 9238.639933382907, 9275.67535136267, 9280.350375473652, 9315.377663266177, 56379.0, 59202.70398647979, 59974.0, 60270.0, 61135.38864611475, 75308.46915308425, 91853.0, 92290.0, 93742.0, 96628.51685741526, 12882.355882205664, 13364.732705346034, 13415.731685366043, 13478.393472293967, 13572.253526056162, 14789.0, 14884.479043233869, 14987.8044522477, 15069.171195584348, 15089.849101508844, 12275.324857132944, 13685.45258189701, 13803.654908627364, 13938.094023888414, 14112.506062288181, 13747.243901585509, 13804.0, 13967.580972570839, 13977.231252280815, 14192.645183870485, 13320.0, 13718.0, 13934.930325348309, 13985.0, 14145.929270353583, 11369.829452558384, 11372.0, 11379.203455758017, 11416.429178541206, 11550.422478875855, 8972.551372431482, 9820.214382849212, 10911.618093366695, 11455.885441145481, 11579.768404632028], "value": 7836.319267047132, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 119.0, 117.0, 131.0, 175.0, 164.0, 118.0, 118.0, 123.0, 118.0], "value": 129.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 110.0, 111.0, 140.0, 141.0, 149.0, 139.0, 93.0, 169.0, 144.0], "value": 134.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 248.0, 234.0, 246.0, 195.0, 194.0, 193.0, 200.0, 192.0, 198.0], "value": 210.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 59.0, 60.0, 82.0, 84.0, 82.0, 51.0, 68.0, 105.0, 85.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 91.0, 96.0, 96.0, 99.0, 99.0, 70.0, 70.0, 86.0], "value": 86.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 86.0, 93.0, 86.0, 83.0, 131.0, 135.0, 85.0], "value": 96.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 125.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 100.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 113.0, 113.0, 126.0, 121.0, 143.0, 134.0, 91.0, 125.0], "value": 115.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 56.0, 57.0, 56.0, 59.0, 57.0, 58.0, 56.0, 55.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 106.0, 110.0, 84.0, 74.0, 69.0, 68.0, 69.0, 68.0, 72.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 93.0, 109.0, 109.0, 104.0, 88.0, 87.0, 87.0, 90.0, 92.0], "value": 93.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 142.0, 137.0, 154.0, 150.0, 154.0, 150.0, 172.0, 141.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 172.0, 232.0, 185.0, 174.0, 171.0, 170.0, 172.0, 171.0, 187.0], "value": 181.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 69.0, 67.0, 71.0, 68.0, 69.0, 68.0, 67.0, 67.0], "value": 68.4, "unit": "score"}]}]} 11:59:56 INFO - Return code: 0 11:59:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:59:57 ERROR - # TBPL SUCCESS # 11:59:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:59:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:59:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:59:57 INFO - 2016-09-23 11:59:57.064 screenresolution[1669:10871] starting screenresolution argv=screenresolution get 11:59:57 INFO - 2016-09-23 11:59:57.066 screenresolution[1669:10871] Display 0: 1600x1200x32@60 11:59:57 INFO - 2016-09-23 11:59:57.072 screenresolution[1670:10874] starting screenresolution argv=screenresolution list 11:59:57 INFO - Available Modes on Display 0 11:59:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:59:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:59:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:59:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:59:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:59:57 INFO - Intel Iris: 11:59:57 INFO - Chipset Model: Intel Iris 11:59:57 INFO - Type: GPU 11:59:57 INFO - Bus: Built-In 11:59:57 INFO - VRAM (Dynamic, Max): 1536 MB 11:59:57 INFO - Vendor: Intel (0x8086) 11:59:57 INFO - Device ID: 0x0a2e 11:59:57 INFO - Revision ID: 0x0009 11:59:57 INFO - Displays: 11:59:57 INFO - Display: 11:59:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:59:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:59:57 INFO - Display Serial Number: 1600x1200 60 11:59:57 INFO - Main Display: Yes 11:59:57 INFO - Mirror: Off 11:59:57 INFO - Online: Yes 11:59:57 INFO - Rotation: Supported 11:59:57 INFO - Return code: 0 11:59:57 INFO - Running post-action listener: _resource_record_post_action 11:59:57 INFO - [mozharness: 2016-09-23 18:59:57.310797Z] Finished run-tests step (success) 11:59:57 INFO - Running post-run listener: _resource_record_post_run 11:59:57 INFO - Total resource usage - Wall time: 1210s; CPU: 55.0%; Read bytes: 32616960; Write bytes: 710174208; Read time: 195; Write time: 2058 11:59:57 INFO - TinderboxPrint: CPU usage
54.6% 11:59:57 INFO - TinderboxPrint: I/O read bytes / time
32,616,960 / 195 11:59:57 INFO - TinderboxPrint: I/O write bytes / time
710,174,208 / 2,058 11:59:57 INFO - TinderboxPrint: CPU idle
2,200.1 (45.4%) 11:59:57 INFO - TinderboxPrint: CPU system
979.1 (20.2%) 11:59:57 INFO - TinderboxPrint: CPU user
1,662.5 (34.3%) 11:59:57 INFO - TinderboxPrint: Swap in / out
435,421,184 / 0 11:59:57 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 399231488; Write bytes: 394361856; Read time: 31522; Write time: 848 11:59:57 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 30638592; Write bytes: 299031040; Read time: 178; Write time: 1165 11:59:57 INFO - Running post-run listener: _upload_blobber_files 11:59:57 INFO - Blob upload gear active. 11:59:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:59:57 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 11:59:57 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'] 11:59:57 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 11:59:58 INFO - (blobuploader) - INFO - Open directory for files ... 11:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:59:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:58 INFO - (blobuploader) - INFO - Done attempting. 11:59:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:59:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:59:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:59:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:59:59 INFO - (blobuploader) - INFO - Done attempting. 11:59:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:59:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:59:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:00:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:00:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:00:05 INFO - (blobuploader) - INFO - Done attempting. 12:00:05 INFO - (blobuploader) - INFO - Iteration through files over. 12:00:05 INFO - Return code: 0 12:00:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:00:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:00:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ef5ec63d805063e76fd15eb90f3814561fc66ecc62eabc1b18831e53553cfb2204e0351939c4a667075c2dbaddba61e0d1791070fe684a2b4e459e37fa7cc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3817183ee48525923007fc81d2d195fb6321013f970f696da91c9769e02a0cc2c8df62063542f45bcb8092d515cd8642baaec9775e78854b777b4b16c1b092a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39aa0ebb626057bf9491f2cb42f0b0a0d3fa9ae1cfaf2fe0d13c9d85a2d8251c4f95fe8ac1dad0971449e4186e30b29ed8e77fb63708c136fe9097ef0bd6abaa"} 12:00:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:00:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:00:05 INFO - Contents: 12:00:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ef5ec63d805063e76fd15eb90f3814561fc66ecc62eabc1b18831e53553cfb2204e0351939c4a667075c2dbaddba61e0d1791070fe684a2b4e459e37fa7cc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3817183ee48525923007fc81d2d195fb6321013f970f696da91c9769e02a0cc2c8df62063542f45bcb8092d515cd8642baaec9775e78854b777b4b16c1b092a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39aa0ebb626057bf9491f2cb42f0b0a0d3fa9ae1cfaf2fe0d13c9d85a2d8251c4f95fe8ac1dad0971449e4186e30b29ed8e77fb63708c136fe9097ef0bd6abaa"} 12:00:05 INFO - Running post-run listener: copy_logs_to_upload_dir 12:00:05 INFO - Copying logs to upload dir... 12:00:05 INFO - mkdir: /builds/slave/test/build/upload/logs 12:00:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.716795 ========= master_lag: 0.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-23 12:00:05.742457) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 12:00:05.747131) ========= 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.A9FZl0HjoP/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.hI44BLZRva/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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/4ef5ec63d805063e76fd15eb90f3814561fc66ecc62eabc1b18831e53553cfb2204e0351939c4a667075c2dbaddba61e0d1791070fe684a2b4e459e37fa7cc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3817183ee48525923007fc81d2d195fb6321013f970f696da91c9769e02a0cc2c8df62063542f45bcb8092d515cd8642baaec9775e78854b777b4b16c1b092a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39aa0ebb626057bf9491f2cb42f0b0a0d3fa9ae1cfaf2fe0d13c9d85a2d8251c4f95fe8ac1dad0971449e4186e30b29ed8e77fb63708c136fe9097ef0bd6abaa"} build_url:https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011007 build_url: 'https://queue.taskcluster.net/v1/task/J1EPJF1YTcW-cwDKpWPxrg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4ef5ec63d805063e76fd15eb90f3814561fc66ecc62eabc1b18831e53553cfb2204e0351939c4a667075c2dbaddba61e0d1791070fe684a2b4e459e37fa7cc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b3817183ee48525923007fc81d2d195fb6321013f970f696da91c9769e02a0cc2c8df62063542f45bcb8092d515cd8642baaec9775e78854b777b4b16c1b092a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/39aa0ebb626057bf9491f2cb42f0b0a0d3fa9ae1cfaf2fe0d13c9d85a2d8251c4f95fe8ac1dad0971449e4186e30b29ed8e77fb63708c136fe9097ef0bd6abaa"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 12:00:05.794379) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 12:00:05.794720) ========= 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.A9FZl0HjoP/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.hI44BLZRva/Listeners TMPDIR=/var/folders/lr/dk8sq3xj3n7gfb5sczdhf_qr00000w/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.004449 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 12:00:05.843545) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 12:00:05.843873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 12:00:05.844315) ========= ========= Total master_lag: 0.79 =========