builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0087 starttime: 1474969952.22 results: success (0) buildid: 20160927004006 builduid: 2fa46ab890014565b4dadf9c9d3483ad revision: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.222578) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.223536) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.224126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.249284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.249955) ========= 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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-27 02:52:32-- 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% 59.7M=0s 2016-09-27 02:52:32 (59.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132367 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.412510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.413650) ========= 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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.022424 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:32.469047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 02:52:32.470028) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OUE8iHV1YU/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.rfNnlD3sQC/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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-27 02:52:32,548 truncating revision to first 12 chars 2016-09-27 02:52:32,548 Setting DEBUG logging. 2016-09-27 02:52:32,549 attempt 1/10 2016-09-27 02:52:32,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/cbd3fd1a66dd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 02:52:34,199 unpacking tar archive at: mozilla-aurora-cbd3fd1a66dd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.914222 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-27 02:52:34.411079) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:34.411465) ========= script_repo_revision: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:34.411898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:34.412201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 02:52:34.432667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-09-27 02:52:34.432997) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OUE8iHV1YU/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.rfNnlD3sQC/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:52:34 INFO - MultiFileLogger online at 20160927 02:52:34 in /builds/slave/test 02:52:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:52:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:52:34 INFO - {'append_to_log': False, 02:52:34 INFO - 'base_work_dir': '/builds/slave/test', 02:52:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:52:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:52:34 INFO - 'branch': 'Mozilla-Aurora', 02:52:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:52:34 INFO - 'config_files': ('talos/mac_config.py',), 02:52:34 INFO - 'default_actions': ('clobber', 02:52:34 INFO - 'read-buildbot-config', 02:52:34 INFO - 'download-and-extract', 02:52:34 INFO - 'populate-webroot', 02:52:34 INFO - 'create-virtualenv', 02:52:34 INFO - 'install', 02:52:34 INFO - 'run-tests'), 02:52:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:52:34 INFO - 'download_minidump_stackwalk': True, 02:52:34 INFO - 'download_symbols': 'ondemand', 02:52:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:52:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:52:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:52:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:52:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:52:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:52:34 INFO - 'installer_path': 'installer.exe', 02:52:34 INFO - 'log_level': 'info', 02:52:34 INFO - 'log_name': 'talos', 02:52:34 INFO - 'log_to_console': True, 02:52:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:52:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:52:34 INFO - 'opt_config_files': (), 02:52:34 INFO - 'pip_index': False, 02:52:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:34 INFO - 'cmd': ('bash', 02:52:34 INFO - '-c', 02:52:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:34 INFO - 'enabled': True, 02:52:34 INFO - 'halt_on_failure': False, 02:52:34 INFO - 'name': 'check_screen_resolution'},), 02:52:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:52:34 INFO - 'cmd': ('bash', 02:52:34 INFO - '-c', 02:52:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:52:34 INFO - 'enabled': True, 02:52:34 INFO - 'halt_on_failure': False, 02:52:34 INFO - 'name': 'check_screen_resolution'},), 02:52:34 INFO - 'run_cmd_checks_enabled': True, 02:52:34 INFO - 'sps_profile': False, 02:52:34 INFO - 'sps_profile_interval': 0, 02:52:34 INFO - 'suite': 'dromaeojs-e10s', 02:52:34 INFO - 'system_bits': '32', 02:52:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:52:34 INFO - 'title': 't-yosemite-r7-0087', 02:52:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:52:34 INFO - 'use_talos_json': True, 02:52:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:52:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:52:34 INFO - 'work_dir': 'build'} 02:52:34 INFO - [mozharness: 2016-09-27 09:52:34.628399Z] Running clobber step. 02:52:34 INFO - Running pre-action listener: _resource_record_pre_action 02:52:34 INFO - Running main action method: clobber 02:52:34 INFO - rmtree: /builds/slave/test/build 02:52:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:52:35 INFO - Running post-action listener: _resource_record_post_action 02:52:35 INFO - [mozharness: 2016-09-27 09:52:35.664415Z] Finished clobber step (success) 02:52:35 INFO - [mozharness: 2016-09-27 09:52:35.664664Z] Running read-buildbot-config step. 02:52:35 INFO - Running pre-action listener: _resource_record_pre_action 02:52:35 INFO - Running main action method: read_buildbot_config 02:52:35 INFO - Using buildbot properties: 02:52:35 INFO - { 02:52:35 INFO - "project": "", 02:52:35 INFO - "product": "firefox", 02:52:35 INFO - "script_repo_revision": "production", 02:52:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:52:35 INFO - "repository": "", 02:52:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:52:35 INFO - "buildid": "20160927004006", 02:52:35 INFO - "stage_platform": "macosx64", 02:52:35 INFO - "basedir": "/builds/slave/test", 02:52:35 INFO - "nightly_build": "True", 02:52:35 INFO - "buildnumber": 405, 02:52:35 INFO - "slavename": "t-yosemite-r7-0087", 02:52:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:52:35 INFO - "platform": "yosemite_r7", 02:52:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:52:35 INFO - "branch": "mozilla-aurora", 02:52:35 INFO - "repo_path": "releases/mozilla-aurora", 02:52:35 INFO - "revision": "cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810", 02:52:35 INFO - "pgo_build": "False", 02:52:35 INFO - "builduid": "2fa46ab890014565b4dadf9c9d3483ad", 02:52:35 INFO - "slavebuilddir": "test" 02:52:35 INFO - } 02:52:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 02:52:35 INFO - Running post-action listener: _resource_record_post_action 02:52:35 INFO - [mozharness: 2016-09-27 09:52:35.670599Z] Finished read-buildbot-config step (success) 02:52:35 INFO - [mozharness: 2016-09-27 09:52:35.670831Z] Running download-and-extract step. 02:52:35 INFO - Running pre-action listener: _resource_record_pre_action 02:52:35 INFO - Running main action method: download_and_extract 02:52:35 INFO - mkdir: /builds/slave/test/build/tests 02:52: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')]} 02:52:35 INFO - trying https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 02:52:35 INFO - Downloading https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:52:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 02:52:36 INFO - Downloaded 1199 bytes. 02:52:36 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 02:52:36 INFO - Using the following test package requirements: 02:52:36 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:52:36 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 02:52:36 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 02:52:36 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'jsshell-mac.zip'], 02:52:36 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 02:52:36 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 02:52:36 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 02:52:36 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 02:52:36 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 02:52:36 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 02:52:36 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 02:52:36 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:52:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:52:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:36 INFO - Fetch https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:52:37 INFO - Expected file size: 16432095 02:52:44 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:52:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 02:52:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:52:44 INFO - Fetch https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 02:52:44 INFO - Expected file size: 16432095 02:52:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 02:52:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:52:51 INFO - Fetch https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 02:52:52 INFO - Expected file size: 14414059 02:52: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')]} 02:52:53 INFO - trying https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:52:53 INFO - Downloading https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 02:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 02:52:55 INFO - Downloaded 115379860 bytes. 02:52:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:52:55 INFO - mkdir: /builds/slave/test/properties 02:52:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:55 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:55 INFO - Contents: 02:52:55 INFO - build_url:https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 02:52:56 INFO - Running post-action listener: _resource_record_post_action 02:52:56 INFO - Running post-action listener: set_extra_try_arguments 02:52:56 INFO - [mozharness: 2016-09-27 09:52:56.561932Z] Finished download-and-extract step (success) 02:52:56 INFO - [mozharness: 2016-09-27 09:52:56.562058Z] Running populate-webroot step. 02:52:56 INFO - Running pre-action listener: _resource_record_pre_action 02:52:56 INFO - Running main action method: populate_webroot 02:52:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:52:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:52:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:52:56 INFO - '--tppagecycles', 02:52:56 INFO - '7'], 02:52:56 INFO - 'tests': ['tsvgm']}}, 02:52:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:52:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:52:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['damp', 'tps']}, 02:52:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'tests': ['damp', 'tps']}, 02:52:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['dromaeo_dom']}, 02:52:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['basic_compositor_video']}, 02:52:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:52:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['a11yr', 02:52:56 INFO - 'ts_paint', 02:52:56 INFO - 'tpaint', 02:52:56 INFO - 'sessionrestore', 02:52:56 INFO - 'sessionrestore_no_auto_restore', 02:52:56 INFO - 'tabpaint']}, 02:52:56 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:56 INFO - 'ts_paint', 02:52:56 INFO - 'tpaint', 02:52:56 INFO - 'sessionrestore', 02:52:56 INFO - 'sessionrestore_no_auto_restore', 02:52:56 INFO - 'tabpaint']}, 02:52:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:52:56 INFO - 'ts_paint', 02:52:56 INFO - 'tpaint', 02:52:56 INFO - 'sessionrestore', 02:52:56 INFO - 'sessionrestore_no_auto_restore', 02:52:56 INFO - 'tabpaint']}, 02:52:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:52:56 INFO - 'ts_paint', 02:52:56 INFO - 'tpaint', 02:52:56 INFO - 'sessionrestore', 02:52:56 INFO - 'sessionrestore_no_auto_restore', 02:52:56 INFO - 'tabpaint']}, 02:52:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['a11yr', 02:52:56 INFO - 'ts_paint', 02:52:56 INFO - 'tpaint', 02:52:56 INFO - 'sessionrestore', 02:52:56 INFO - 'sessionrestore_no_auto_restore', 02:52:56 INFO - 'tabpaint']}, 02:52:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['a11yr', 02:52:56 INFO - 'ts_paint', 02:52:56 INFO - 'tpaint', 02:52:56 INFO - 'sessionrestore', 02:52:56 INFO - 'sessionrestore_no_auto_restore', 02:52:56 INFO - 'tabpaint']}, 02:52:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['tsvgx', 02:52:56 INFO - 'tsvgr_opacity', 02:52:56 INFO - 'tart', 02:52:56 INFO - 'tscrollx', 02:52:56 INFO - 'cart']}, 02:52:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:56 INFO - 'tsvgr_opacity', 02:52:56 INFO - 'tart', 02:52:56 INFO - 'tscrollx', 02:52:56 INFO - 'cart']}, 02:52:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'talos_options': ['--disable-e10s'], 02:52:56 INFO - 'tests': ['tp5o']}, 02:52:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'tests': ['tp5o']}, 02:52:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'talos_options': ['--disable-e10s', 02:52:56 INFO - '--xperf_path', 02:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:56 INFO - 'tests': ['tp5n']}, 02:52:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:52:56 INFO - 'talos_options': ['--xperf_path', 02:52:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:56 INFO - 'tests': ['tp5n']}}, 02:52:56 INFO - 'talos.zip': {'path': '', 02:52:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:52:56 INFO - Running post-action listener: _resource_record_post_action 02:52:56 INFO - [mozharness: 2016-09-27 09:52:56.580809Z] Finished populate-webroot step (success) 02:52:56 INFO - [mozharness: 2016-09-27 09:52:56.580926Z] Running create-virtualenv step. 02:52:56 INFO - Running pre-action listener: _resource_record_pre_action 02:52:56 INFO - Running main action method: create_virtualenv 02:52:56 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:56 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 02:52:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:56 INFO - Using real prefix '/tools/python27' 02:52:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:57 INFO - Installing distribute.............................................................................................................................................................................................done. 02:53:00 INFO - Installing pip.................done. 02:53:00 INFO - Return code: 0 02:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:00 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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:00 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 02:53:00 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 02:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:00 INFO - 'HOME': '/Users/cltbld', 02:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:00 INFO - 'LOGNAME': 'cltbld', 02:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:00 INFO - 'MOZ_NO_REMOTE': '1', 02:53:00 INFO - 'NO_EM_RESTART': '1', 02:53:00 INFO - 'PAGER': '/bin/cat', 02:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:00 INFO - 'PWD': '/builds/slave/test', 02:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:00 INFO - 'SHELL': '/bin/bash', 02:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:00 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:00 INFO - 'USER': 'cltbld', 02:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:00 INFO - 'XPC_FLAGS': '0x0', 02:53:00 INFO - 'XPC_SERVICE_NAME': '0', 02:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:00 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 02:53:00 INFO - Cleaning up... 02:53:00 INFO - Return code: 0 02:53:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:00 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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:00 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 02:53:00 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 02:53:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:00 INFO - 'HOME': '/Users/cltbld', 02:53:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:00 INFO - 'LOGNAME': 'cltbld', 02:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:00 INFO - 'MOZ_NO_REMOTE': '1', 02:53:00 INFO - 'NO_EM_RESTART': '1', 02:53:00 INFO - 'PAGER': '/bin/cat', 02:53:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:00 INFO - 'PWD': '/builds/slave/test', 02:53:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:00 INFO - 'SHELL': '/bin/bash', 02:53:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:00 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:00 INFO - 'USER': 'cltbld', 02:53:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:00 INFO - 'XPC_FLAGS': '0x0', 02:53:00 INFO - 'XPC_SERVICE_NAME': '0', 02:53:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:00 INFO - Downloading/unpacking psutil>=3.1.1 02:53:00 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 02:53:00 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 02:53:00 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 02:53:00 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 02:53:00 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 02:53:00 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 02:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:03 INFO - Installing collected packages: psutil 02:53:03 INFO - Running setup.py install for psutil 02:53:03 INFO - building 'psutil._psutil_osx' extension 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 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 02:53:03 INFO - building 'psutil._psutil_posix' extension 02:53:03 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 02:53:04 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:53:04 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:53:04 INFO - ^ 02:53:04 INFO - 1 warning generated. 02:53:04 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 02:53:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:53:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:53:04 INFO - Successfully installed psutil 02:53:04 INFO - Cleaning up... 02:53:04 INFO - Return code: 0 02:53:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:53:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:53:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:04 INFO - 'HOME': '/Users/cltbld', 02:53:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:04 INFO - 'LOGNAME': 'cltbld', 02:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:04 INFO - 'MOZ_NO_REMOTE': '1', 02:53:04 INFO - 'NO_EM_RESTART': '1', 02:53:04 INFO - 'PAGER': '/bin/cat', 02:53:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:04 INFO - 'PWD': '/builds/slave/test', 02:53:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:04 INFO - 'SHELL': '/bin/bash', 02:53:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:04 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:04 INFO - 'USER': 'cltbld', 02:53:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:04 INFO - 'XPC_FLAGS': '0x0', 02:53:04 INFO - 'XPC_SERVICE_NAME': '0', 02:53:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:53:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:53:07 INFO - Installing collected packages: mozsystemmonitor 02:53:07 INFO - Running setup.py install for mozsystemmonitor 02:53:07 INFO - Successfully installed mozsystemmonitor 02:53:07 INFO - Cleaning up... 02:53:07 INFO - Return code: 0 02:53:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:53:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:53:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:07 INFO - 'HOME': '/Users/cltbld', 02:53:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:07 INFO - 'LOGNAME': 'cltbld', 02:53:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:07 INFO - 'MOZ_NO_REMOTE': '1', 02:53:07 INFO - 'NO_EM_RESTART': '1', 02:53:07 INFO - 'PAGER': '/bin/cat', 02:53:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:07 INFO - 'PWD': '/builds/slave/test', 02:53:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:07 INFO - 'SHELL': '/bin/bash', 02:53:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:07 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:07 INFO - 'USER': 'cltbld', 02:53:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:07 INFO - 'XPC_FLAGS': '0x0', 02:53:07 INFO - 'XPC_SERVICE_NAME': '0', 02:53:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:07 INFO - Downloading/unpacking jsonschema==2.5.1 02:53:07 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 02:53:07 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 02:53:07 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 02:53:07 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 02:53:07 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 02:53:07 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 02:53:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:53:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:53:10 INFO - warning: no files found matching '*.txt' 02:53:10 INFO - no previously-included directories found matching 'build' 02:53:10 INFO - no previously-included directories found matching 'dist' 02:53:10 INFO - no previously-included directories found matching '.git*' 02:53:10 INFO - Installing collected packages: jsonschema, functools32 02:53:10 INFO - Running setup.py install for functools32 02:53:10 INFO - warning: no files found matching '*.txt' 02:53:10 INFO - no previously-included directories found matching 'build' 02:53:10 INFO - no previously-included directories found matching 'dist' 02:53:10 INFO - no previously-included directories found matching '.git*' 02:53:10 INFO - Successfully installed jsonschema functools32 02:53:10 INFO - Cleaning up... 02:53:10 INFO - Return code: 0 02:53:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:10 INFO - 'HOME': '/Users/cltbld', 02:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:10 INFO - 'LOGNAME': 'cltbld', 02:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:10 INFO - 'MOZ_NO_REMOTE': '1', 02:53:10 INFO - 'NO_EM_RESTART': '1', 02:53:10 INFO - 'PAGER': '/bin/cat', 02:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:10 INFO - 'PWD': '/builds/slave/test', 02:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:10 INFO - 'SHELL': '/bin/bash', 02:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:10 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:10 INFO - 'USER': 'cltbld', 02:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:10 INFO - 'XPC_FLAGS': '0x0', 02:53:10 INFO - 'XPC_SERVICE_NAME': '0', 02:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:53:11 INFO - Cleaning up... 02:53:11 INFO - Return code: 0 02:53:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:53:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:11 INFO - 'HOME': '/Users/cltbld', 02:53:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:11 INFO - 'LOGNAME': 'cltbld', 02:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:11 INFO - 'MOZ_NO_REMOTE': '1', 02:53:11 INFO - 'NO_EM_RESTART': '1', 02:53:11 INFO - 'PAGER': '/bin/cat', 02:53:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:11 INFO - 'PWD': '/builds/slave/test', 02:53:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:11 INFO - 'SHELL': '/bin/bash', 02:53:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:11 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:11 INFO - 'USER': 'cltbld', 02:53:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:11 INFO - 'XPC_FLAGS': '0x0', 02:53:11 INFO - 'XPC_SERVICE_NAME': '0', 02:53:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:53:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:53:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:14 INFO - Downloading docopt-0.6.1.tar.gz 02:53:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:53:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:53:15 INFO - Running setup.py install for blobuploader 02:53:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:53:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:53:15 INFO - Running setup.py install for requests 02:53:15 INFO - Running setup.py install for docopt 02:53:15 INFO - Successfully installed blobuploader requests docopt 02:53:15 INFO - Cleaning up... 02:53:16 INFO - Return code: 0 02:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:16 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')]} 02:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:16 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')]} 02:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:16 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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:16 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 02:53:16 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 02:53:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:16 INFO - 'HOME': '/Users/cltbld', 02:53:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:16 INFO - 'LOGNAME': 'cltbld', 02:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:16 INFO - 'MOZ_NO_REMOTE': '1', 02:53:16 INFO - 'NO_EM_RESTART': '1', 02:53:16 INFO - 'PAGER': '/bin/cat', 02:53:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:16 INFO - 'PWD': '/builds/slave/test', 02:53:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:16 INFO - 'SHELL': '/bin/bash', 02:53:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:16 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:16 INFO - 'USER': 'cltbld', 02:53:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:16 INFO - 'XPC_FLAGS': '0x0', 02:53:16 INFO - 'XPC_SERVICE_NAME': '0', 02:53:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-jjp_Z3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-jfYQiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-AfiMtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-J7kHTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-Svc8kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-q0H7gG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-0xXKrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:16 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-wmo6PW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-0Jfpfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-VILjyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-a6lKGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-lrS_sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-yut1vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-7ldUzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-uTnf4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-SmMn2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:17 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-b9rTyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:53:18 INFO - Running setup.py install for manifestparser 02:53:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozcrash 02:53:18 INFO - Running setup.py install for mozdebug 02:53:18 INFO - Running setup.py install for mozdevice 02:53:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozfile 02:53:18 INFO - Running setup.py install for mozhttpd 02:53:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:53:18 INFO - Running setup.py install for mozinfo 02:53:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for mozInstall 02:53:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for mozleak 02:53:19 INFO - Running setup.py install for mozlog 02:53:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for moznetwork 02:53:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:53:19 INFO - Running setup.py install for mozprocess 02:53:19 INFO - Running setup.py install for mozprofile 02:53:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:53:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:53:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:53:20 INFO - Running setup.py install for mozrunner 02:53:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:53:20 INFO - Running setup.py install for mozscreenshot 02:53:20 INFO - Running setup.py install for moztest 02:53:20 INFO - Running setup.py install for mozversion 02:53:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:53:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:53:20 INFO - Cleaning up... 02:53:20 INFO - Return code: 0 02:53:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:20 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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:20 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 02:53:20 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 02:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:20 INFO - 'HOME': '/Users/cltbld', 02:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:20 INFO - 'LOGNAME': 'cltbld', 02:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:20 INFO - 'MOZ_NO_REMOTE': '1', 02:53:20 INFO - 'NO_EM_RESTART': '1', 02:53:20 INFO - 'PAGER': '/bin/cat', 02:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:20 INFO - 'PWD': '/builds/slave/test', 02:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:20 INFO - 'SHELL': '/bin/bash', 02:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:20 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:20 INFO - 'USER': 'cltbld', 02:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:20 INFO - 'XPC_FLAGS': '0x0', 02:53:20 INFO - 'XPC_SERVICE_NAME': '0', 02:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:53:20 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-qSf09N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-g2q_SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-P7qhyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-mmTDXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-1PI7j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-DGNLBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-WHvdii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-DqvkcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-_0jqM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:53:21 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)) 02:53:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:53:21 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-dtSwqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-BB0YHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-RlKuuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-_ywDa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-4T1qVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-hHJXBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-RM__Hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:53:22 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)) 02:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:53:22 INFO - Running setup.py (path:/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/pip-CF9bg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:53:22 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)) 02:53:22 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)) 02:53:22 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)) 02:53:22 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)) 02:53:22 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)) 02:53:22 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)) 02:53:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:53:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:53:25 INFO - Downloading blessings-1.6.tar.gz 02:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:53:25 INFO - Installing collected packages: blessings 02:53:25 INFO - Running setup.py install for blessings 02:53:25 INFO - Successfully installed blessings 02:53:25 INFO - Cleaning up... 02:53:25 INFO - Return code: 0 02:53:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:25 INFO - Reading from file tmpfile_stdout 02:53:25 INFO - Current package versions: 02:53:25 INFO - blessings == 1.6 02:53:25 INFO - blobuploader == 1.2.4 02:53:25 INFO - docopt == 0.6.1 02:53:25 INFO - functools32 == 3.2.3-2 02:53:25 INFO - jsonschema == 2.5.1 02:53:25 INFO - manifestparser == 1.1 02:53:25 INFO - mozInstall == 1.12 02:53:25 INFO - mozcrash == 0.17 02:53:25 INFO - mozdebug == 0.1 02:53:25 INFO - mozdevice == 0.48 02:53:25 INFO - mozfile == 1.2 02:53:25 INFO - mozhttpd == 0.7 02:53:25 INFO - mozinfo == 0.9 02:53:25 INFO - mozleak == 0.1 02:53:25 INFO - mozlog == 3.4 02:53:25 INFO - moznetwork == 0.27 02:53:25 INFO - mozprocess == 0.23 02:53:25 INFO - mozprofile == 0.28 02:53:25 INFO - mozrunner == 6.12 02:53:25 INFO - mozscreenshot == 0.1 02:53:25 INFO - mozsystemmonitor == 0.3 02:53:25 INFO - moztest == 0.7 02:53:25 INFO - mozversion == 1.4 02:53:25 INFO - psutil == 3.1.1 02:53:25 INFO - requests == 1.2.3 02:53:25 INFO - wsgiref == 0.1.2 02:53:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:53:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53:26 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 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53:26 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 02:53:26 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 02:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:26 INFO - 'HOME': '/Users/cltbld', 02:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:26 INFO - 'LOGNAME': 'cltbld', 02:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:26 INFO - 'MOZ_NO_REMOTE': '1', 02:53:26 INFO - 'NO_EM_RESTART': '1', 02:53:26 INFO - 'PAGER': '/bin/cat', 02:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:26 INFO - 'PWD': '/builds/slave/test', 02:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:26 INFO - 'SHELL': '/bin/bash', 02:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:26 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:26 INFO - 'USER': 'cltbld', 02:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:26 INFO - 'XPC_FLAGS': '0x0', 02:53:26 INFO - 'XPC_SERVICE_NAME': '0', 02:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 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)) 02:53:26 INFO - Cleaning up... 02:53:26 INFO - Return code: 0 02:53:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:53: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')]} 02:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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')]} 02:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:53: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103bf0490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b66570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9b5bcd9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, '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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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 02:53: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'] in /builds/slave/test/build 02:53: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 02:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:53:26 INFO - 'HOME': '/Users/cltbld', 02:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:53:26 INFO - 'LOGNAME': 'cltbld', 02:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:53:26 INFO - 'MOZ_NO_REMOTE': '1', 02:53:26 INFO - 'NO_EM_RESTART': '1', 02:53:26 INFO - 'PAGER': '/bin/cat', 02:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:53:26 INFO - 'PWD': '/builds/slave/test', 02:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:53:26 INFO - 'SHELL': '/bin/bash', 02:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:53:26 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:53:26 INFO - 'USER': 'cltbld', 02:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:53:26 INFO - 'XPC_FLAGS': '0x0', 02:53:26 INFO - 'XPC_SERVICE_NAME': '0', 02:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:53:27 INFO - Cleaning up... 02:53:27 INFO - Return code: 0 02:53:27 INFO - Running post-action listener: _resource_record_post_action 02:53:27 INFO - Running post-action listener: _start_resource_monitoring 02:53:27 INFO - Starting resource monitoring. 02:53:27 INFO - [mozharness: 2016-09-27 09:53:27.245712Z] Finished create-virtualenv step (success) 02:53:27 INFO - [mozharness: 2016-09-27 09:53:27.246763Z] Running install step. 02:53:27 INFO - Running pre-action listener: _resource_record_pre_action 02:53:27 INFO - Running main action method: install 02:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:53:27 INFO - Reading from file tmpfile_stdout 02:53:27 INFO - Detecting whether we're running mozinstall >=1.0... 02:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:53:27 INFO - Reading from file tmpfile_stdout 02:53:27 INFO - Output received: 02:53:27 INFO - Usage: mozinstall [options] installer 02:53:27 INFO - Options: 02:53:27 INFO - -h, --help show this help message and exit 02:53:27 INFO - -d DEST, --destination=DEST 02:53:27 INFO - Directory to install application into. [default: 02:53:27 INFO - "/builds/slave/test"] 02:53:27 INFO - --app=APP Application being installed. [default: firefox] 02:53:27 INFO - mkdir: /builds/slave/test/build/application 02:53:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:53:59 INFO - Reading from file tmpfile_stdout 02:53:59 INFO - Output received: 02:53:59 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:53:59 INFO - Running post-action listener: _resource_record_post_action 02:53:59 INFO - [mozharness: 2016-09-27 09:53:59.749317Z] Finished install step (success) 02:53:59 INFO - [mozharness: 2016-09-27 09:53:59.749467Z] Running run-tests step. 02:53:59 INFO - Running pre-action listener: _resource_record_pre_action 02:53:59 INFO - Running main action method: run_tests 02:53:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:53:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:53:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:53:59 INFO - 2016-09-27 02:53:59.764 screenresolution[2583:294144] starting screenresolution argv=screenresolution get 02:53:59 INFO - 2016-09-27 02:53:59.767 screenresolution[2583:294144] Display 0: 1600x1200x32@60 02:53:59 INFO - 2016-09-27 02:53:59.773 screenresolution[2584:294147] starting screenresolution argv=screenresolution list 02:53:59 INFO - Available Modes on Display 0 02:53:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:53:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:53:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:53:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:54:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:54:00 INFO - Intel Iris: 02:54:00 INFO - Chipset Model: Intel Iris 02:54:00 INFO - Type: GPU 02:54:00 INFO - Bus: Built-In 02:54:00 INFO - VRAM (Dynamic, Max): 1536 MB 02:54:00 INFO - Vendor: Intel (0x8086) 02:54:00 INFO - Device ID: 0x0a2e 02:54:00 INFO - Revision ID: 0x0009 02:54:00 INFO - Displays: 02:54:00 INFO - Display: 02:54:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:54:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:54:00 INFO - Display Serial Number: 1600x1200 60 02:54:00 INFO - Main Display: Yes 02:54:00 INFO - Mirror: Off 02:54:00 INFO - Online: Yes 02:54:00 INFO - Rotation: Supported 02:54:00 INFO - Return code: 0 02:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:54:00 INFO - Python 2.7.3 02:54:00 INFO - Return code: 0 02:54:00 INFO - grabbing minidump binary from tooltool 02:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:54:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103a04d30>, '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 0x10386adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1039fcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:54:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:54:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 02:54:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:54:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:54:00 INFO - Return code: 0 02:54:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:54:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:54:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:54:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:54:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:54:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 02:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0087 --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 02:54:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OUE8iHV1YU/Render', 02:54:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:54:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:54:00 INFO - 'HOME': '/Users/cltbld', 02:54:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:54:00 INFO - 'LOGNAME': 'cltbld', 02:54:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:54:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:54:00 INFO - 'MOZ_NO_REMOTE': '1', 02:54:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:54:00 INFO - 'NO_EM_RESTART': '1', 02:54:00 INFO - 'PAGER': '/bin/cat', 02:54:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:54:00 INFO - 'PWD': '/builds/slave/test', 02:54:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:54:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:54:00 INFO - 'SHELL': '/bin/bash', 02:54:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rfNnlD3sQC/Listeners', 02:54:00 INFO - 'TMPDIR': '/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/', 02:54:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:54:00 INFO - 'USER': 'cltbld', 02:54:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:54:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:54:00 INFO - 'XPC_FLAGS': '0x0', 02:54:00 INFO - 'XPC_SERVICE_NAME': '0', 02:54:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:54:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0087', '--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 02:54:00 INFO - mozversion application_buildid: 20160927004006 02:54:00 INFO - mozversion application_changeset: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 02:54:00 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:54:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:54:00 INFO - mozversion application_name: Firefox 02:54:00 INFO - mozversion application_remotingname: firefox-dev 02:54:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:54:00 INFO - mozversion application_vendor: Mozilla 02:54:00 INFO - mozversion application_version: 51.0a2 02:54:00 INFO - mozversion platform_buildid: 20160927004006 02:54:00 INFO - mozversion platform_changeset: cbd3fd1a66ddf48d6e41350d63ddc207c2f1f810 02:54:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:54:00 INFO - mozversion platform_version: 51.0a2 02:54:00 INFO - using testdate: 1474970040 02:54:00 INFO - actual date: 1474970040 02:54:00 INFO - starting webserver on 'localhost:53823' 02:54:00 INFO - SUITE-START | Running 2 tests 02:54:00 INFO - TEST-START | dromaeo_css 02:54:00 INFO - operating with platform_type : mac_ 02:54:00 INFO - Initialising browser for dromaeo_css test... 02:54:00 INFO - TEST-INFO | started process 2594 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpekDAdC/profile http://localhost:53823/getInfo.html) 02:54:03 INFO - PROCESS | 2594 | __metrics Screen width/height:1600/1200 02:54:03 INFO - PROCESS | 2594 | colorDepth:24 02:54:03 INFO - PROCESS | 2594 | Browser inner width/height: 1024/689 02:54:03 INFO - PROCESS | 2594 | __metrics 02:54:03 ERROR - PROCESS | 2594 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 02:54:04 INFO - TEST-INFO | 2594: exit 0 02:54:04 INFO - Browser initialized. 02:54:04 INFO - Running cycle 1/1 for dromaeo_css test... 02:54:04 INFO - TEST-INFO | started process 2598 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmpekDAdC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:54:16 INFO - PROCESS | 2598 | RSS: Main: 224649216 02:54:16 INFO - PROCESS | 2598 | 02:55:05 INFO - PROCESS | 2598 | 1474970105831 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] 02:57:18 INFO - PROCESS | 2598 | Cycle 1(1): loaded http://localhost:53823/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53823/tests/dromaeo/cssquery-ext.html) 02:57:19 INFO - PROCESS | 2598 | RSS: Main: 236326912 02:57:19 INFO - PROCESS | 2598 | 03:00:21 INFO - PROCESS | 2598 | Cycle 1(1): loaded http://localhost:53823/tests/dromaeo/cssquery-ext.html (next: http://localhost:53823/tests/dromaeo/cssquery-jquery.html) 03:00:22 INFO - PROCESS | 2598 | RSS: Main: 247779328 03:00:22 INFO - PROCESS | 2598 | 03:03:24 INFO - PROCESS | 2598 | Cycle 1(1): loaded http://localhost:53823/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53823/tests/dromaeo/cssquery-mootools.html) 03:03:25 INFO - PROCESS | 2598 | RSS: Main: 250724352 03:03:25 INFO - PROCESS | 2598 | 03:06:26 INFO - PROCESS | 2598 | Cycle 1(1): loaded http://localhost:53823/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53823/tests/dromaeo/cssquery-prototype.html) 03:06:27 INFO - PROCESS | 2598 | RSS: Main: 251510784 03:06:27 INFO - PROCESS | 2598 | 03:09:30 INFO - PROCESS | 2598 | Cycle 1(1): loaded http://localhost:53823/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53823/tests/dromaeo/cssquery-yui.html) 03:09:30 INFO - PROCESS | 2598 | RSS: Main: 256995328 03:09:30 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | Cycle 1(1): loaded http://localhost:53823/tests/dromaeo/cssquery-yui.html (next: http://localhost:53823/tests/dromaeo/cssquery-dojo.html) 03:12:33 INFO - PROCESS | 2598 | RSS: Main: 259772416 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | __start_tp_report 03:12:33 INFO - PROCESS | 2598 | _x_x_mozilla_page_load 03:12:33 INFO - PROCESS | 2598 | _x_x_mozilla_page_load_details 03:12:33 INFO - PROCESS | 2598 | |i|pagename|runs| 03:12:33 INFO - PROCESS | 2598 | |0;dojo.html;3406.829658517074;3415.197428604278;3426.880059197928;3445.104272889048;3467.9942816583175;5806.33227178874;5873.236479257701;5898.351181370057;5898.911516327258;5913.497352725023;5870.412958704127;5957.374475680056;5964.582479226456;5969.582129250944;5971.432713892184;5315.601329900263;5337.332833395825;5407.729613519328;5438.6736795792185;5462.262594549725;5382.6232163748355;5409.26974858393;5411.648242864221;5413.404525502211;5417.970585588745;5257.763400646961;5292.576593872481;5318.228856815759;5412.431694672062;5471.124620060791;5368.221607866857;5409.404965453797;5415.431379705134;5433.049216387156;5473.480019398151;5225.581953443715;5346.4386239445075;5361.0426908924055;5370.355557333106;5383.4616538346245;4866.416030076378;5351.66208447888;5540;5892.1161825726485;6092.208012958331;5087.236914462823;5402.945970540323;6148.800983808159;6226.782062627832;6250.34371391002;6217.409346112112;6228.5017198624;6299.023651334051;6299.716512756937;6318.210223722035;5029.698218106925;5497.890042199134;5742.82771516851;5797.913031304533;6017.638941663514;6228.750849966042;6273.686315684289;6293.213348331458;6337.6197428154455;6397.072424498421;6189.597676151036;6240.282367527792;6261.5616906816995;6272.717727702265;6305.180326557518;5257.263983042377;6086.360932102154;6319.905201421982;6322.747090116344;6334.113224148623;5844.88310233793;6194.225721784777;6225.097360882737;6234.812955611339;6270.623762574169;6220.409061139185;6266.592671476339;6271.372862713783;6273.968630156911;6282.748690052438;5049.949500505021;5049.949500505021;5055.064813009605;5074.746262686851;5083.161278389024;4435.911281774346;4438.423005009328;4459.241928872099;4482.798274077674;4505.504394516601;6005.099235114681;6118.296395914438;6119.5104391648565;6122.571420000557;6137.324894261627;6183.319834818167;6257;6294.559380843297;6311.463525600376;6367.299597044322;5049.661839612506;5919.585629005928;5962.791302304398;5979.790707325223;6122.142899994004;5507;5507.5593952483705;5509.559235261169;5523.25436066134;5535.916961245584;6447.806565803034;6463.515236357292;6492.058651495412;6493.577917435352;6503.804885853432;6161.845953851011;6188.040853667689;6209.751609935733;6223.190985171898;6245.250569931637;5642.589352661835;6268.153799237045;6502.154719886385;6515.804525864231;6521.67391630426;6202.379762023762;6257.906131407942;6275.37246275387;6285.277193122666;6302.936970630235;6161;6183.443490085914;6196.318404975539;6233.376662333731;6314.431701146735;6171.382861713792;6237.28271248794;6242.656653883898;6249.468795152463;6262.46769024638;6172.290186628596;6220.782272620618;6239.1577137085915;6248.843778905381;6271.717772700148;5542.584306176972;5883.646981181143;5888.705564721832;6019;6086.6348019119;5164.9741751291;5446.373667028184;6049.213602231857;6120.660465672032;6133.601315914451;4892.92660610084;5819.854503637443;5991.071383935497;5997.070454079625;6009.399060093956 03:12:33 INFO - PROCESS | 2598 | |1;ext.html;455.4284373111745;472.97398643074627;520.1833121998461;554.7559074007437;594.1651978969544;39119.80440097799;42416.9395765106;42514.57485425145;42558.57441425585;42710.7864460678;36206.63793362066;43694;43990.780046099804;43994.34008489867;44043.77978110105;9774.16919561838;9944.5524951377;9954.701358959242;9976.251781116409;9978.850317245247;9837.163841073518;9918.355306905065;9936.205103591696;9943.90056099437;9968.700938971842;9880.209583233323;9930.900690993107;9961.75095622608;9975.301728878982;9985.90014099857;9897.356671816346;9941.502924853728;9944.254180936387;9951.651692190811;9956.452395118265;9827.90172098277;9854.605815767361;9897.505124743733;9900.90099099007;9928.404295742279;41787.955301117414;42134.78932605348;42145.946351341154;42176.78911605422;42305.57694423047;3258.3809076275434;3416.367971925202;3629.872954446582;3834.2331533693373;4119.320312148492;31083.68916310853;31620;32001.51997720036;32399.190020249447;32680;3211.807291562514;3253.5933008373954;3312.03950854252;3319.3527262183884;3405.7105146062613;521527;524904;526654.9999999962;527129;528344;64911;65236.34763652303;65433.345666543675;65571;65592;35654;36085.09787255339;36785.81607091947;36901.81549092291;37460.81269593634;17479.475615731295;17614.735778963324;17628.735568966476;17661.38185163513;17723.556911077067;13459.730805383837;13540.187588744708;13624.18254904709;13642.86357136416;13659.838913692447;19685.01574921248;19830.008499574964;19890.60218795616;20010.499737506678;20021.399358019284;8143.022837259567;8152.796180095426;8160.795980100545;8207.343412526983;8245.752627421187;886.9334799890034;1000.8098461292332;1016.3901659004538;1073.8335557988523;1090.7600327927844;29743.851280743456;31731.365372692417;31984.84007579947;32147.196320091716;32322.35355292881;1003.3327836988467;1027.2244455436098;1050.6375300521308;1059.6662051453768;1083.9566417343217;14112.788308175386;17422.912885435744;17446.65106697859;17544;18141;559594;706784.4660776663;707910;708232;710765;49741.502584973685;60245.493862653784;60363;60618;60816;1343.946242150303;1370.1778932640336;1403.4736973634888;1403.8104855844535;1404.9789253161211;24068.638970415108;30935;32927.83536082304;33320.50019249762;34085.82957085199;53069;53337.73331133475;53481.66295842479;53619.731901340245;53658.463415365346;620142.8921409366;624836;628663;629058.8547057236;631239;27897;28057.719422805512;28391.858040709663;28398.574021390108;28414.43171136607;47772.761136194094;48077;49273.753631231615;49669.25496117489;49689.50310496993;33169.668303316656;39689.60310396975;41629.79185104055;41809.74570762882;42042;40610.1877962445;40673.59326406698;40853.38719919144;41545;41784.79107604443;34732.65267347395;35578.64421355857;39468.80265598654;40315.79842100888;42853;34135.31729365449;36262.29147607701;36930;36993.63006369902;37076.44385334276;20528.692069619265;26379;26510.602340965288;26821.731782681924;26847.926082956463 03:12:33 INFO - PROCESS | 2598 | |2;jquery.html;323.53734160150975;344.6760045557176;375.42934739196403;380.1522604591759;383.6987964447909;19354;20106.296279630198;20489;20737.170513179455;21006;16663.41678041269;16850.915745421287;19876.60246795067;20115;20255.797442025574;5385.3268341457315;5769;5804.767809287634;6019.097135429677;6073.453389194971;5763.481286684198;6016.157737916695;6087.239095113111;6127.203463549732;6171.845703857394;6004.429579189992;6056.121862329959;6088.969555152218;6136.018237082068;6137.447629713325;6070.726817293233;6140.263168419819;6180.721867515973;6192.225971753508;6200.503959683215;5781.710914454303;5931.080682494177;6050.062240352709;6069.787557435468;6070.908936365958;12946.093773435863;13123.540676076387;13128.409221585052;17672.558186045324;24176.637350439756;2334.1480359668767;2334.9066037358484;2404.603240465339;2439.6462512935705;2991.5512673098992;7995.520268783892;8081.353491720648;9146.588403521857;9694.854577181348;10155.28912976092;1814.401247588306;1850.5466160790559;1855.1002763659749;1880.304287413652;1904.2478221102726;129050;129274;129609;131899;133583;9285.953570232106;11441.713957151138;11682;11737.823932641017;11895;14548.636284092983;14762.557123286319;14843.332050057774;14852;14856.405743770345;8630.309575233967;8718.564071796385;8751.562421879007;8783.824323513494;8922.553872306358;8634.050254472004;8768.736937891874;8823;8986.775330616787;9025.909740902507;3696.5933747287777;4470;4479.59683628475;4578.679492435497;4679.883002924954;1703.5485596316985;1918.8368988635843;1961.4704029911843;1970.3694817658497;1973.4178417366625;860.423516244118;939.9060093990684;961.4856052012279;1022.9028242316969;1029.2280789407944;19216.61566768657;20316.467083824828;20473.48816279605;20558.38324850257;20888.268910588056;951.4006176109007;963.6868017894212;965.4979410706393;986.921046316293;998.1316254858319;10322.380657160595;10741.892581074246;10858.34849909008;10905.291156074829;10908;533940;560928;581535;656214;659672;92004;137748;144182;147923.52076479312;148104;950.2587981374539;984.6947446291816;994.9751256218652;1000.229823036258;1002.3033991376069;18293.451196464128;18834;18869.056547172313;18875.811241887404;18935.621287574446;52715;56515;56779.71610141923;58086.7095664519;58602;59336;65080.67459662671;66091.67816643543;67611.32388676248;81814.59092704498;7980.920190798018;8014.879776803469;8119.5534245617055;8164.428490005643;8258.29804466603;10790.514426850654;11253.549858005588;12102.152849300817;12531.248125112523;12717.936410317889;9036.864447033431;10218.897811021794;10302.433366164933;10558.683239502827;10743.570257189938;9496.240300775784;10421.06210441064;10450.58197672115;10455.843162352723;10536.683899483029;10652.147828173882;10743.677689669323;10778.29941053829;10850.511726972463;11057.502412391623;6189.783357582463;7931.127575966754;8179.018517777667;8298.83402331938;8514.148585141436;8148.266656000988;10454.477276136011;11192.88807111951;11214.327140371604;11216.943915280372 03:12:33 INFO - PROCESS | 2598 | |3;mootools.html;1508.4946542908122;1548.9612759681006;1729.377424127314;1833.669939410907;1845.1512304339994;8175.632096555654;8437.831243375143;8633.35249856261;9197.586108625112;9212.769680757985;8629.352798540103;8929.330300227493;8933.731988040354;9018.323625728064;9019.23336516397;2361.988190059047;2374.287713685896;2406.4585468269674;2415.7342692303832;2424.3939015246187;2384.844985075973;2404.7955923746504;2429.2833614083797;2431.8054555635595;2432.428379330856;2158;2400.3879010852297;2411.963820542693;2420.2134306350417;2438.0735320578156;2381.357033600918;2395.401149712572;2402.087206861399;2407.0010945457616;2412.469256763518;2384.6542251373453;2403.65147053678;2404.987975060131;2406.3863714752624;2411.867347295898;8898.59956301968;9035.774105647346;9061.59222834974;9064.501452420114;9067.909320906772;5328.92006619901;5487.890242195173;5500.037493438632;5504.174373843915;5506.284183056177;3123.6251649801943;3641.7814931104217;3691.446283057536;3717.8512859485586;3750.5124333836425;1107.4905543449943;1114.921955463118;1119.356370087195;1119.9664010079712;1143.2111842828422;11922.880771192351;12025.458854351575;12119.93940030303;12128.878711212863;12147.08896832741;4474.664400169935;4618.445786505641;4726.858194254178;4765.785539650724;4771.73755443447;9201.4479131251;9336.953315233517;9352.625894964262;9355;9363.063693630582;4689.132510485571;5123.590112790967;5272.420033796279;5344.064788662046;5379.897121090167;3813.733038687321;4490.753008584494;4832.734199618984;4969;4989.501049894981;3848.807559622008;3871.128995975883;3970.2059588082498;3993.560708322082;4014.0767623446186;1191.5293459083787;1196.5393323570313;1200.5257923120319;1209.232137592635;1211.981820272679;718.7771790744886;903.7198468474794;925.6343744220995;932.934694571387;935.2050756856753;4844.685095468853;5857.062869940789;5896.528277737856;5898.882022359615;6202.782902598387;449.13093164725706;451.2869665927826;452.77587594141113;465.2509459769768;468.3466564143001;4010.9197816044098;4032.0927791247323;4043.110515686544;4063.959360406417;4086.7956602169775;8951.73144805657;11122.833157502644;11147.609833655782;11166.665000050012;11174.553017879194;11063.668089957315;11084.113270938306;11088.722781930355;11104.222704410775;11131.554737810558;6456.709448074848;8366.623501942428;8435.198656127657;8474.406791524658;8488.957555212308;5259.684418934723;5943.64338139713;6076.3012253591405;6160.398296442868;6227;9795;9942.652007179713;10167.7458063549;10176.033276838689;10233.232507562112;10279.94860025695;10434.06093451593;10458.529366178387;10506.894931050592;10590.735231619272;5923.259592550931;7118.9644051779405;7644.80887977805;7751.689932402866;7880.369570434237;8579.713043043594;8639.568021599021;8676.305895528469;8681.348898832739;8685.828542864285;7540.9622951884885;7609.086909570887;7615.504992175491;7784.026996625422;7882.605869706606;7052.2242553318065;7521.699132034657;7573.431992600466;7679.040119985002;7741.651625676971;6188.040853667689;6393.456556192776;6465.676716164267;7015.333543313581;7085.256048114874;4232.682548808913;5071.568916642127;5186.351706036746;5222.686638801684;5236.764345604381;5113.130767769414;5143.794248230179;5242.475752424727;5251.684898906078;5279.709615971158 03:12:33 INFO - PROCESS | 2598 | |4;prototype.html;286.30285255403095;291.7913691710427;301.9350839569492;305.40903352013856;317.9459491886379;5374.811881584145;5438.646487978289;5627.155926611005;5723.914141287879;5738.7417566209515;4787.8563643090765;5300.946990530094;5574.749136288867;5608.186812912125;5716.857078573038;4137.448456828689;4303.289957157065;4309.5259521452535;4327.697061205717;4353.978230108845;3804.7824696097123;4145.253854306224;4289.914201715964;4344.891377715567;4347.347897815322;4205.516365617963;4208.884645568926;4238.262312451895;4271.78641067947;4288.592583704543;4245.702800803945;4254.787260636971;4281.250781113293;4292.5492823253735;4318.740875547477;2882.942341153186;3523.9295214095832;3615.529981102466;3710.424884142962;3736.580099562176;5483.561315094783;5489.941272022991;5506.256655351516;5528.419515950807;5535.418781027975;4530.909381812346;4893;4961.206207006861;4984.900301993976;4993.650444468889;5062.784931616422;5225.581953443753;5465.699386533739;5638.859028524279;5960.7019649017375;3426.468897320919;4050.696197785178;4078.3678529827926;4085.530164031115;4105.281575724266;5545.639533430314;5910.793122240744;6224.595401298901;6297.874042519124;6303.621782693053;3974.5826688197903;4064.4919385076864;4149.8962525937095;4186.539480657125;4205.179989902001;4071.8395257352104;4199.475065616798;4217.472815898012;4227.556106608762;4245.787710614457;4568.81724731007;4892.804287828447;4942.332785073969;4974.602031837444;4991.326170966946;4784.808607655655;4803.879903002383;5516.586256030814;5571.832845014656;5925.4520556160405;1223.3210568134593;1295.3458503455884;1333.5465941579716;1392.6031081141825;1394.716860488333;822.3585603229491;840.5587066789984;846.221476241859;851.7955690634203;855.5209082913589;4320.746983374849;4560;4637.7449240291435;4822.903541929212;4839.733814640158;4475.1428157315;4983.084895336269;4991.727109587032;5003.9241563064115;5043.672161309503;4287.213311347649;4532.546745325441;4658.5293956003;4718.575328220477;4742.5731684148595;2484.714257860333;2724.2372135802007;2876.5828954801436;3279.8032118072992;3287.7041066304146;6282.277538083087;6420.935790642127;6442.710078046499;6495.253045899782;6500.317466666026;5388.595855310868;6225.346338634378;6256.43692067707;6382.361763823674;6417.812704649655;6323.20959880015;6446.967765161145;6456.289808121103;6489.935100648933;6534.411902928759;4955.571769832828;5320.600954928474;5812.157237200498;5875.970620146872;5981.192539007352;5379.246905433164;5478.479544443271;5706.914396284142;5766.145757849891;6162.815115546541;5425;5955.553333499918;6392.968035159794;6516.967415162894;6544.803655890331;3594.8382322795014;3799.8670046548236;3837.771912987817;3926.7251292409255;3931.1351502669368;5547.55619550443;5967.254093238345;6125.816225513242;6195.747232702867;6252.5935814171935;5600;5979.970100149645;5996.970015149896;6027.126066720213;6129.693515324305;5383.757730902197;5568.582356323211;5706.629069110494;5876.647401155944;5890;4898.975505122452;4998.350214472241;5759.646483076557;5853.590248682552;5917.852053698692;5221.459669397613;5342.732863356894;5840;5914.172015917689;5974.312954010345;5582.358028826737;5815.6914694193465;5837.423895548093;5875.3243377012195;5890.381509941394 03:12:33 INFO - PROCESS | 2598 | |5;yui.html;687.8066554527896;700.5446459801126;721.96029218393;783.0525064671747;827.9586020698965;15305.464308749197;15313.310901009454;15778;15818.683626327467;15854.048757074585;14105.647358816035;14127.434902603909;14180.361883715232;14199.787003194935;14209.715805683905;671.1778071861954;694.0630149298457;844.214880161448;846.826400587878;877.1754550722301;877.5875338590852;877.8902637170354;882.8322618702458;884.0982198157875;886.0297973718767;940.8776859008319;944.263474489899;945.2910317262053;947.0434860790616;947.6446332625266;918.7427520294328;931.2736065868634;934.2339281788936;935.7099299217231;939.0093451408761;684.384054351083;691.2016620802981;698.5913240754165;699.8005568412977;700.9193942696604;14322.355494002795;14723.558293251219;14751.483698070624;14756.70486590273;15005;11694.590689325832;12026.338551379671;12754.80867786984;14422.783658245029;15037.097774133477;11773.352465614387;11896.167268291223;11979.640610781691;12003.579874704343;12039.09706771987;3721.6464435878547;3785.8296376663116;3855.4987851579394;3859.07382228266;3983.382575700771;91145.26564203085;119413;123435;123576.9999999991;125302;9538.570764315484;10999.34003959765;11262.436878156059;11332.830007549894;11371.886281137247;19499.31752388688;23443.7655623445;23470;23652;23720.64419033716;8156.429049966564;8223.95888020556;8276.668933242603;8293.95853020743;8462.746117616482;4402.3616575597;4536.183486972311;4587;4606.493285738566;4643.257078867365;3640.672339489459;3701.7408781385043;3759.9060023499082;3769.0577355661085;3777.527809023872;644.6486664767713;655.4297760948006;656.5371413153811;671.3387313496203;681.9113515242987;536.6190005096425;607.5959486941223;656.8160914943824;676.671814170127;697.7034760226883;9334.906650933539;9637.18083962857;9705.417674939526;9764.414135151914;9904.613354130428;569.7407679505815;635.3836778325017;673.2526895146384;680.3026897430075;685.6126288646899;4642.373279607277;4721;4736.834210802605;4748.3114948332295;4785.904281914342;101765.49117254514;142144;151090.24454877657;168180;171772;110030;111449;114765.42617287027;127435.36282318529;132102.33948830195;68553.65723171452;94691;95048;98605.50697246467;102578.48710756548;8520.403571749917;8685.652573896974;9783.26625503076;10213.846792297973;10306.381617102998;36793.63206368009;41933.37099943564;42479.93800155021;49698.01207951641;57327.426725732206;75412.24587754052;84560.15439845523;87229;90606;101721;10904.563817447213;11138.721531961766;12167.634970950885;12906.806397904227;13596.524121655695;13726.107802992774;14083.295835208404;14476.782848257495;15774.842251577338;15849.326925946985;11301.26541774782;12341.197822141532;12364.56724014655;13317.400716967953;14842.332095055965;11735.941320293345;11947.701307467383;11991.460384282555;12128.939355303168;14083.788743168656;13445.46218151263;13665.18008919468;13782;13949.721005579628;13973.161610303414;9879.456629885139;9978.451185184884;10702.789163250838;10941.734249520636;11231.941894803977;11402.657920262405;11573.884261157618;11614.709632258922;11639.304214299724;11890.821637675268 03:12:33 INFO - PROCESS | 2598 | __end_tp_report 03:12:33 INFO - PROCESS | 2598 | __start_cc_report 03:12:33 INFO - PROCESS | 2598 | _x_x_mozilla_cycle_collect,369 03:12:33 INFO - PROCESS | 2598 | __end_cc_report 03:12:33 INFO - PROCESS | 2598 | __startTimestamp1474971153862__endTimestamp 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | ------- Summary: start ------- 03:12:33 INFO - PROCESS | 2598 | Number of tests: 6 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | [#0] dojo.html Cycles:165 Average:5788.82 Median:6009.40 stddev:641.16 (10.7%) stddev-sans-first:615.29 03:12:33 INFO - PROCESS | 2598 | Values: 3406.8 3415.2 3426.9 3445.1 3468.0 5806.3 5873.2 5898.4 5898.9 5913.5 5870.4 5957.4 5964.6 5969.6 5971.4 5315.6 5337.3 5407.7 5438.7 5462.3 5382.6 5409.3 5411.6 5413.4 5418.0 5257.8 5292.6 5318.2 5412.4 5471.1 5368.2 5409.4 5415.4 5433.0 5473.5 5225.6 5346.4 5361.0 5370.4 5383.5 4866.4 5351.7 5540.0 5892.1 6092.2 5087.2 5402.9 6148.8 6226.8 6250.3 6217.4 6228.5 6299.0 6299.7 6318.2 5029.7 5497.9 5742.8 5797.9 6017.6 6228.8 6273.7 6293.2 6337.6 6397.1 6189.6 6240.3 6261.6 6272.7 6305.2 5257.3 6086.4 6319.9 6322.7 6334.1 5844.9 6194.2 6225.1 6234.8 6270.6 6220.4 6266.6 6271.4 6274.0 6282.7 5049.9 5049.9 5055.1 5074.7 5083.2 4435.9 4438.4 4459.2 4482.8 4505.5 6005.1 6118.3 6119.5 6122.6 6137.3 6183.3 6257.0 6294.6 6311.5 6367.3 5049.7 5919.6 5962.8 5979.8 6122.1 5507.0 5507.6 5509.6 5523.3 5535.9 6447.8 6463.5 6492.1 6493.6 6503.8 6161.8 6188.0 6209.8 6223.2 6245.3 5642.6 6268.2 6502.2 6515.8 6521.7 6202.4 6257.9 6275.4 6285.3 6302.9 6161.0 6183.4 6196.3 6233.4 6314.4 6171.4 6237.3 6242.7 6249.5 6262.5 6172.3 6220.8 6239.2 6248.8 6271.7 5542.6 5883.6 5888.7 6019.0 6086.6 5165.0 5446.4 6049.2 6120.7 6133.6 4892.9 5819.9 5991.1 5997.1 6009.4 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | [#1] ext.html Cycles:180 Average:73909.99 Median:41587.40 stddev:164490.03 (395.5%) stddev-sans-first:164859.01 03:12:33 INFO - PROCESS | 2598 | Values: 455.4 473.0 520.2 554.8 594.2 39119.8 42416.9 42514.6 42558.6 42710.8 36206.6 43694.0 43990.8 43994.3 44043.8 9774.2 9944.6 9954.7 9976.3 9978.9 9837.2 9918.4 9936.2 9943.9 9968.7 9880.2 9930.9 9961.8 9975.3 9985.9 9897.4 9941.5 9944.3 9951.7 9956.5 9827.9 9854.6 9897.5 9900.9 9928.4 41788.0 42134.8 42145.9 42176.8 42305.6 3258.4 3416.4 3629.9 3834.2 4119.3 31083.7 31620.0 32001.5 32399.2 32680.0 3211.8 3253.6 3312.0 3319.4 3405.7 521527.0 524904.0 526655.0 527129.0 528344.0 64911.0 65236.3 65433.3 65571.0 65592.0 35654.0 36085.1 36785.8 36901.8 37460.8 17479.5 17614.7 17628.7 17661.4 17723.6 13459.7 13540.2 13624.2 13642.9 13659.8 19685.0 19830.0 19890.6 20010.5 20021.4 8143.0 8152.8 8160.8 8207.3 8245.8 886.9 1000.8 1016.4 1073.8 1090.8 29743.9 31731.4 31984.8 32147.2 32322.4 1003.3 1027.2 1050.6 1059.7 1084.0 14112.8 17422.9 17446.7 17544.0 18141.0 559594.0 706784.5 707910.0 708232.0 710765.0 49741.5 60245.5 60363.0 60618.0 60816.0 1343.9 1370.2 1403.5 1403.8 1405.0 24068.6 30935.0 32927.8 33320.5 34085.8 53069.0 53337.7 53481.7 53619.7 53658.5 620142.9 624836.0 628663.0 629058.9 631239.0 27897.0 28057.7 28391.9 28398.6 28414.4 47772.8 48077.0 49273.8 49669.3 49689.5 33169.7 39689.6 41629.8 41809.7 42042.0 40610.2 40673.6 40853.4 41545.0 41784.8 34732.7 35578.6 39468.8 40315.8 42853.0 34135.3 36262.3 36930.0 36993.6 37076.4 20528.7 26379.0 26510.6 26821.7 26847.9 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | [#2] jquery.html Cycles:180 Average:34968.82 Median:334.11 stddev:100768.25 (30160.5%) stddev-sans-first:101017.35 03:12:33 INFO - PROCESS | 2598 | Values: 323.5 344.7 375.4 380.2 383.7 19354.0 20106.3 20489.0 20737.2 21006.0 16663.4 16850.9 19876.6 20115.0 20255.8 5385.3 5769.0 5804.8 6019.1 6073.5 5763.5 6016.2 6087.2 6127.2 6171.8 6004.4 6056.1 6089.0 6136.0 6137.4 6070.7 6140.3 6180.7 6192.2 6200.5 5781.7 5931.1 6050.1 6069.8 6070.9 12946.1 13123.5 13128.4 17672.6 24176.6 2334.1 2334.9 2404.6 2439.6 2991.6 7995.5 8081.4 9146.6 9694.9 10155.3 1814.4 1850.5 1855.1 1880.3 1904.2 129050.0 129274.0 129609.0 131899.0 133583.0 9286.0 11441.7 11682.0 11737.8 11895.0 14548.6 14762.6 14843.3 14852.0 14856.4 8630.3 8718.6 8751.6 8783.8 8922.6 8634.1 8768.7 8823.0 8986.8 9025.9 3696.6 4470.0 4479.6 4578.7 4679.9 1703.5 1918.8 1961.5 1970.4 1973.4 860.4 939.9 961.5 1022.9 1029.2 19216.6 20316.5 20473.5 20558.4 20888.3 951.4 963.7 965.5 986.9 998.1 10322.4 10741.9 10858.3 10905.3 10908.0 533940.0 560928.0 581535.0 656214.0 659672.0 92004.0 137748.0 144182.0 147923.5 148104.0 950.3 984.7 995.0 1000.2 1002.3 18293.5 18834.0 18869.1 18875.8 18935.6 52715.0 56515.0 56779.7 58086.7 58602.0 59336.0 65080.7 66091.7 67611.3 81814.6 7980.9 8014.9 8119.6 8164.4 8258.3 10790.5 11253.5 12102.2 12531.2 12717.9 9036.9 10218.9 10302.4 10558.7 10743.6 9496.2 10421.1 10450.6 10455.8 10536.7 10652.1 10743.7 10778.3 10850.5 11057.5 6189.8 7931.1 8179.0 8298.8 8514.1 8148.3 10454.5 11192.9 11214.3 11216.9 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | [#3] mootools.html Cycles:180 Average:5746.26 Median:4802.24 stddev:3275.88 (68.2%) stddev-sans-first:3269.59 03:12:33 INFO - PROCESS | 2598 | Values: 1508.5 1549.0 1729.4 1833.7 1845.2 8175.6 8437.8 8633.4 9197.6 9212.8 8629.4 8929.3 8933.7 9018.3 9019.2 2362.0 2374.3 2406.5 2415.7 2424.4 2384.8 2404.8 2429.3 2431.8 2432.4 2158.0 2400.4 2412.0 2420.2 2438.1 2381.4 2395.4 2402.1 2407.0 2412.5 2384.7 2403.7 2405.0 2406.4 2411.9 8898.6 9035.8 9061.6 9064.5 9067.9 5328.9 5487.9 5500.0 5504.2 5506.3 3123.6 3641.8 3691.4 3717.9 3750.5 1107.5 1114.9 1119.4 1120.0 1143.2 11922.9 12025.5 12119.9 12128.9 12147.1 4474.7 4618.4 4726.9 4765.8 4771.7 9201.4 9337.0 9352.6 9355.0 9363.1 4689.1 5123.6 5272.4 5344.1 5379.9 3813.7 4490.8 4832.7 4969.0 4989.5 3848.8 3871.1 3970.2 3993.6 4014.1 1191.5 1196.5 1200.5 1209.2 1212.0 718.8 903.7 925.6 932.9 935.2 4844.7 5857.1 5896.5 5898.9 6202.8 449.1 451.3 452.8 465.3 468.3 4010.9 4032.1 4043.1 4064.0 4086.8 8951.7 11122.8 11147.6 11166.7 11174.6 11063.7 11084.1 11088.7 11104.2 11131.6 6456.7 8366.6 8435.2 8474.4 8489.0 5259.7 5943.6 6076.3 6160.4 6227.0 9795.0 9942.7 10167.7 10176.0 10233.2 10279.9 10434.1 10458.5 10506.9 10590.7 5923.3 7119.0 7644.8 7751.7 7880.4 8579.7 8639.6 8676.3 8681.3 8685.8 7541.0 7609.1 7615.5 7784.0 7882.6 7052.2 7521.7 7573.4 7679.0 7741.7 6188.0 6393.5 6465.7 7015.3 7085.3 4232.7 5071.6 5186.4 5222.7 5236.8 5113.1 5143.8 5242.5 5251.7 5279.7 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | [#4] prototype.html Cycles:180 Average:4728.70 Median:5053.23 stddev:1484.20 (29.4%) stddev-sans-first:1450.42 03:12:33 INFO - PROCESS | 2598 | Values: 286.3 291.8 301.9 305.4 317.9 5374.8 5438.6 5627.2 5723.9 5738.7 4787.9 5300.9 5574.7 5608.2 5716.9 4137.4 4303.3 4309.5 4327.7 4354.0 3804.8 4145.3 4289.9 4344.9 4347.3 4205.5 4208.9 4238.3 4271.8 4288.6 4245.7 4254.8 4281.3 4292.5 4318.7 2882.9 3523.9 3615.5 3710.4 3736.6 5483.6 5489.9 5506.3 5528.4 5535.4 4530.9 4893.0 4961.2 4984.9 4993.7 5062.8 5225.6 5465.7 5638.9 5960.7 3426.5 4050.7 4078.4 4085.5 4105.3 5545.6 5910.8 6224.6 6297.9 6303.6 3974.6 4064.5 4149.9 4186.5 4205.2 4071.8 4199.5 4217.5 4227.6 4245.8 4568.8 4892.8 4942.3 4974.6 4991.3 4784.8 4803.9 5516.6 5571.8 5925.5 1223.3 1295.3 1333.5 1392.6 1394.7 822.4 840.6 846.2 851.8 855.5 4320.7 4560.0 4637.7 4822.9 4839.7 4475.1 4983.1 4991.7 5003.9 5043.7 4287.2 4532.5 4658.5 4718.6 4742.6 2484.7 2724.2 2876.6 3279.8 3287.7 6282.3 6420.9 6442.7 6495.3 6500.3 5388.6 6225.3 6256.4 6382.4 6417.8 6323.2 6447.0 6456.3 6489.9 6534.4 4955.6 5320.6 5812.2 5876.0 5981.2 5379.2 5478.5 5706.9 5766.1 6162.8 5425.0 5955.6 6393.0 6517.0 6544.8 3594.8 3799.9 3837.8 3926.7 3931.1 5547.6 5967.3 6125.8 6195.7 6252.6 5600.0 5980.0 5997.0 6027.1 6129.7 5383.8 5568.6 5706.6 5876.6 5890.0 4899.0 4998.4 5759.6 5853.6 5917.9 5221.5 5342.7 5840.0 5914.2 5974.3 5582.4 5815.7 5837.4 5875.3 5890.4 03:12:33 INFO - PROCESS | 2598 | 03:12:33 INFO - PROCESS | 2598 | [#5] yui.html Cycles:180 Average:23631.94 Median:3773.29 stddev:38024.34 (1007.7%) stddev-sans-first:38091.98 03:12:33 INFO - PROCESS | 2598 | Values: 687.8 700.5 722.0 783.1 828.0 15305.5 15313.3 15778.0 15818.7 15854.0 14105.6 14127.4 14180.4 14199.8 14209.7 671.2 694.1 844.2 846.8 877.2 877.6 877.9 882.8 884.1 886.0 940.9 944.3 945.3 947.0 947.6 918.7 931.3 934.2 935.7 939.0 684.4 691.2 698.6 699.8 700.9 14322.4 14723.6 14751.5 14756.7 15005.0 11694.6 12026.3 12754.8 14422.8 15037.1 11773.4 11896.2 11979.6 12003.6 12039.1 3721.6 3785.8 3855.5 3859.1 3983.4 91145.3 119413.0 123435.0 123577.0 125302.0 9538.6 10999.3 11262.4 11332.8 11371.9 19499.3 23443.8 23470.0 23652.0 23720.6 8156.4 8224.0 8276.7 8294.0 8462.7 4402.4 4536.2 4587.0 4606.5 4643.3 3640.7 3701.7 3759.9 3769.1 3777.5 644.6 655.4 656.5 671.3 681.9 536.6 607.6 656.8 676.7 697.7 9334.9 9637.2 9705.4 9764.4 9904.6 569.7 635.4 673.3 680.3 685.6 4642.4 4721.0 4736.8 4748.3 4785.9 101765.5 142144.0 151090.2 168180.0 171772.0 110030.0 111449.0 114765.4 127435.4 132102.3 68553.7 94691.0 95048.0 98605.5 102578.5 8520.4 8685.7 9783.3 10213.8 10306.4 36793.6 41933.4 42479.9 49698.0 57327.4 75412.2 84560.2 87229.0 90606.0 101721.0 10904.6 11138.7 12167.6 12906.8 13596.5 13726.1 14083.3 14476.8 15774.8 15849.3 11301.3 12341.2 12364.6 13317.4 14842.3 11735.9 11947.7 11991.5 12128.9 14083.8 13445.5 13665.2 13782.0 13949.7 13973.2 9879.5 9978.5 10702.8 10941.7 11231.9 11402.7 11573.9 11614.7 11639.3 11890.8 03:12:33 INFO - PROCESS | 2598 | -------- Summary: end -------- 03:12:33 INFO - PROCESS | 2598 | 03:12:34 INFO - TEST-INFO | 2598: exit 0 03:12:34 INFO - TEST-OK | dromaeo_css | took 1114142ms 03:12:34 INFO - TEST-START | kraken 03:12:34 INFO - operating with platform_type : mac_ 03:12:34 INFO - Initialising browser for kraken test... 03:12:34 INFO - TEST-INFO | started process 2604 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmp51duiU/profile http://localhost:53823/getInfo.html) 03:12:37 INFO - PROCESS | 2604 | __metrics Screen width/height:1600/1200 03:12:37 INFO - PROCESS | 2604 | colorDepth:24 03:12:37 INFO - PROCESS | 2604 | Browser inner width/height: 1024/689 03:12:37 INFO - PROCESS | 2604 | __metrics 03:12:37 ERROR - PROCESS | 2604 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 03:12:37 INFO - TEST-INFO | 2604: exit 0 03:12:37 INFO - Browser initialized. 03:12:37 INFO - Running cycle 1/1 for kraken test... 03:12:37 INFO - TEST-INFO | started process 2607 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/tmp51duiU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:12:50 INFO - PROCESS | 2607 | RSS: Main: 225099776 03:12:50 INFO - PROCESS | 2607 | 03:12:52 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53823/tests/kraken/driver.html?testName=audio-beat-detection) 03:12:53 INFO - PROCESS | 2607 | RSS: Main: 237215744 03:12:53 INFO - PROCESS | 2607 | 03:12:56 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53823/tests/kraken/driver.html?testName=audio-dft) 03:12:56 INFO - PROCESS | 2607 | RSS: Main: 244486144 03:12:56 INFO - PROCESS | 2607 | 03:13:00 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53823/tests/kraken/driver.html?testName=audio-fft) 03:13:00 INFO - PROCESS | 2607 | RSS: Main: 248467456 03:13:00 INFO - PROCESS | 2607 | 03:13:02 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53823/tests/kraken/driver.html?testName=audio-oscillator) 03:13:03 INFO - PROCESS | 2607 | RSS: Main: 249999360 03:13:03 INFO - PROCESS | 2607 | 03:13:05 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53823/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:13:05 INFO - PROCESS | 2607 | RSS: Main: 250130432 03:13:05 INFO - PROCESS | 2607 | 03:13:08 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53823/tests/kraken/driver.html?testName=imaging-darkroom) 03:13:09 INFO - PROCESS | 2607 | RSS: Main: 251248640 03:13:09 INFO - PROCESS | 2607 | 03:13:12 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53823/tests/kraken/driver.html?testName=imaging-desaturate) 03:13:12 INFO - PROCESS | 2607 | RSS: Main: 251056128 03:13:12 INFO - PROCESS | 2607 | 03:13:15 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53823/tests/kraken/driver.html?testName=json-parse-financial) 03:13:16 INFO - PROCESS | 2607 | RSS: Main: 251518976 03:13:16 INFO - PROCESS | 2607 | 03:13:17 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53823/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:13:18 INFO - PROCESS | 2607 | RSS: Main: 250658816 03:13:18 INFO - PROCESS | 2607 | 03:13:20 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:13:21 INFO - PROCESS | 2607 | RSS: Main: 250732544 03:13:21 INFO - PROCESS | 2607 | 03:13:23 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:13:24 INFO - PROCESS | 2607 | RSS: Main: 250679296 03:13:24 INFO - PROCESS | 2607 | 03:13:27 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:13:27 INFO - PROCESS | 2607 | RSS: Main: 250748928 03:13:27 INFO - PROCESS | 2607 | 03:13:30 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:13:31 INFO - PROCESS | 2607 | RSS: Main: 251019264 03:13:31 INFO - PROCESS | 2607 | 03:13:32 INFO - PROCESS | 2607 | Cycle 1(1): loaded http://localhost:53823/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53823/tests/kraken/driver.html?testName=ai-astar) 03:13:33 INFO - PROCESS | 2607 | RSS: Main: 252485632 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | __start_tp_report 03:13:33 INFO - PROCESS | 2607 | _x_x_mozilla_page_load 03:13:33 INFO - PROCESS | 2607 | _x_x_mozilla_page_load_details 03:13:33 INFO - PROCESS | 2607 | |i|pagename|runs| 03:13:33 INFO - PROCESS | 2607 | |0;ai-astar;105;117;118;118;122;118;119;119;119;118 03:13:33 INFO - PROCESS | 2607 | |1;audio-beat-detection;151;110;119;175;112;116;113;131;142;111 03:13:33 INFO - PROCESS | 2607 | |2;audio-dft;196;229;219;200;195;200;195;199;205;197 03:13:33 INFO - PROCESS | 2607 | |3;audio-fft;84;57;59;86;60;58;57;58;77;58 03:13:33 INFO - PROCESS | 2607 | |4;audio-oscillator;93;70;88;73;68;72;89;69;71;86 03:13:33 INFO - PROCESS | 2607 | |5;imaging-gaussian-blur;89;76;135;132;93;88;89;75;106;134 03:13:33 INFO - PROCESS | 2607 | |6;imaging-darkroom;93;96;94;95;94;95;95;107;125;93 03:13:33 INFO - PROCESS | 2607 | |7;imaging-desaturate;112;127;118;91;92;95;91;92;138;95 03:13:33 INFO - PROCESS | 2607 | |8;json-parse-financial;53;58;50;54;58;59;59;59;58;58 03:13:33 INFO - PROCESS | 2607 | |9;json-stringify-tinderbox;67;73;66;82;78;75;92;102;104;88 03:13:33 INFO - PROCESS | 2607 | |10;stanford-crypto-aes;91;86;85;83;86;82;83;83;85;90 03:13:33 INFO - PROCESS | 2607 | |11;stanford-crypto-ccm;137;143;147;153;154;143;163;156;182;139 03:13:33 INFO - PROCESS | 2607 | |12;stanford-crypto-pbkdf2;164;157;183;165;164;169;180;194;191;229 03:13:33 INFO - PROCESS | 2607 | |13;stanford-crypto-sha256-iterative;69;66;69;60;63;64;64;65;67;61 03:13:33 INFO - PROCESS | 2607 | __end_tp_report 03:13:33 INFO - PROCESS | 2607 | __start_cc_report 03:13:33 INFO - PROCESS | 2607 | _x_x_mozilla_cycle_collect,957 03:13:33 INFO - PROCESS | 2607 | __end_cc_report 03:13:33 INFO - PROCESS | 2607 | __startTimestamp1474971213184__endTimestamp 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | ------- Summary: start ------- 03:13:33 INFO - PROCESS | 2607 | Number of tests: 14 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#0] ai-astar Cycles:10 Average:117.30 Median:118.50 stddev:4.52 (3.8%) stddev-sans-first:1.41 03:13:33 INFO - PROCESS | 2607 | Values: 105.0 117.0 118.0 118.0 122.0 118.0 119.0 119.0 119.0 118.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:125.00 stddev:21.76 (17.4%) stddev-sans-first:21.43 03:13:33 INFO - PROCESS | 2607 | Values: 151.0 110.0 119.0 175.0 112.0 116.0 113.0 131.0 142.0 111.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#2] audio-dft Cycles:10 Average:203.50 Median:200.00 stddev:11.45 (5.7%) stddev-sans-first:11.82 03:13:33 INFO - PROCESS | 2607 | Values: 196.0 229.0 219.0 200.0 195.0 200.0 195.0 199.0 205.0 197.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#3] audio-fft Cycles:10 Average:65.40 Median:59.50 stddev:11.93 (20.0%) stddev-sans-first:10.58 03:13:33 INFO - PROCESS | 2607 | Values: 84.0 57.0 59.0 86.0 60.0 58.0 57.0 58.0 77.0 58.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:79.50 stddev:9.80 (12.3%) stddev-sans-first:8.74 03:13:33 INFO - PROCESS | 2607 | Values: 93.0 70.0 88.0 73.0 68.0 72.0 89.0 69.0 71.0 86.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#5] imaging-gaussian-blur Cycles:10 Average:101.70 Median:82.00 stddev:23.68 (28.9%) stddev-sans-first:24.67 03:13:33 INFO - PROCESS | 2607 | Values: 89.0 76.0 135.0 132.0 93.0 88.0 89.0 75.0 106.0 134.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#6] imaging-darkroom Cycles:10 Average:98.70 Median:94.50 stddev:10.10 (10.7%) stddev-sans-first:10.50 03:13:33 INFO - PROCESS | 2607 | Values: 93.0 96.0 94.0 95.0 94.0 95.0 95.0 107.0 125.0 93.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#7] imaging-desaturate Cycles:10 Average:105.10 Median:91.50 stddev:17.39 (19.0%) stddev-sans-first:18.26 03:13:33 INFO - PROCESS | 2607 | Values: 112.0 127.0 118.0 91.0 92.0 95.0 91.0 92.0 138.0 95.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:58.00 stddev:3.13 (5.4%) stddev-sans-first:3.04 03:13:33 INFO - PROCESS | 2607 | Values: 53.0 58.0 50.0 54.0 58.0 59.0 59.0 59.0 58.0 58.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#9] json-stringify-tinderbox Cycles:10 Average:82.70 Median:76.50 stddev:13.51 (17.7%) stddev-sans-first:13.08 03:13:33 INFO - PROCESS | 2607 | Values: 67.0 73.0 66.0 82.0 78.0 75.0 92.0 102.0 104.0 88.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.50 stddev:3.03 (3.5%) stddev-sans-first:2.44 03:13:33 INFO - PROCESS | 2607 | Values: 91.0 86.0 85.0 83.0 86.0 82.0 83.0 83.0 85.0 90.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#11] stanford-crypto-ccm Cycles:10 Average:151.70 Median:153.50 stddev:13.43 (8.7%) stddev-sans-first:13.14 03:13:33 INFO - PROCESS | 2607 | Values: 137.0 143.0 147.0 153.0 154.0 143.0 163.0 156.0 182.0 139.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.60 Median:181.50 stddev:21.38 (11.8%) stddev-sans-first:21.91 03:13:33 INFO - PROCESS | 2607 | Values: 164.0 157.0 183.0 165.0 164.0 169.0 180.0 194.0 191.0 229.0 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - PROCESS | 2607 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.50 stddev:3.05 (4.7%) stddev-sans-first:2.83 03:13:33 INFO - PROCESS | 2607 | Values: 69.0 66.0 69.0 60.0 63.0 64.0 64.0 65.0 67.0 61.0 03:13:33 INFO - PROCESS | 2607 | -------- Summary: end -------- 03:13:33 INFO - PROCESS | 2607 | 03:13:33 INFO - TEST-INFO | 2607: exit 0 03:13:34 INFO - TEST-OK | kraken | took 59503ms 03:13:34 INFO - SUITE-END | took 1173s 03:13:34 INFO - Completed test suite (00:19:34) 03:13:34 INFO - javascript benchmark 03:13:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7407.01001233393, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3406.829658517074, 3415.197428604278, 3426.880059197928, 3445.104272889048, 3467.9942816583175, 5806.33227178874, 5873.236479257701, 5898.351181370057, 5898.911516327258, 5913.497352725023, 5870.412958704127, 5957.374475680056, 5964.582479226456, 5969.582129250944, 5971.432713892184, 5315.601329900263, 5337.332833395825, 5407.729613519328, 5438.6736795792185, 5462.262594549725, 5382.6232163748355, 5409.26974858393, 5411.648242864221, 5413.404525502211, 5417.970585588745, 5257.763400646961, 5292.576593872481, 5318.228856815759, 5412.431694672062, 5471.124620060791, 5368.221607866857, 5409.404965453797, 5415.431379705134, 5433.049216387156, 5473.480019398151, 5225.581953443715, 5346.4386239445075, 5361.0426908924055, 5370.355557333106, 5383.4616538346245, 4866.416030076378, 5351.66208447888, 5540.0, 5892.1161825726485, 6092.208012958331, 5087.236914462823, 5402.945970540323, 6148.800983808159, 6226.782062627832, 6250.34371391002, 6217.409346112112, 6228.5017198624, 6299.023651334051, 6299.716512756937, 6318.210223722035, 5029.698218106925, 5497.890042199134, 5742.82771516851, 5797.913031304533, 6017.638941663514, 6228.750849966042, 6273.686315684289, 6293.213348331458, 6337.6197428154455, 6397.072424498421, 6189.597676151036, 6240.282367527792, 6261.5616906816995, 6272.717727702265, 6305.180326557518, 5257.263983042377, 6086.360932102154, 6319.905201421982, 6322.747090116344, 6334.113224148623, 5844.88310233793, 6194.225721784777, 6225.097360882737, 6234.812955611339, 6270.623762574169, 6220.409061139185, 6266.592671476339, 6271.372862713783, 6273.968630156911, 6282.748690052438, 5049.949500505021, 5049.949500505021, 5055.064813009605, 5074.746262686851, 5083.161278389024, 4435.911281774346, 4438.423005009328, 4459.241928872099, 4482.798274077674, 4505.504394516601, 6005.099235114681, 6118.296395914438, 6119.5104391648565, 6122.571420000557, 6137.324894261627, 6183.319834818167, 6257.0, 6294.559380843297, 6311.463525600376, 6367.299597044322, 5049.661839612506, 5919.585629005928, 5962.791302304398, 5979.790707325223, 6122.142899994004, 5507.0, 5507.5593952483705, 5509.559235261169, 5523.25436066134, 5535.916961245584, 6447.806565803034, 6463.515236357292, 6492.058651495412, 6493.577917435352, 6503.804885853432, 6161.845953851011, 6188.040853667689, 6209.751609935733, 6223.190985171898, 6245.250569931637, 5642.589352661835, 6268.153799237045, 6502.154719886385, 6515.804525864231, 6521.67391630426, 6202.379762023762, 6257.906131407942, 6275.37246275387, 6285.277193122666, 6302.936970630235, 6161.0, 6183.443490085914, 6196.318404975539, 6233.376662333731, 6314.431701146735, 6171.382861713792, 6237.28271248794, 6242.656653883898, 6249.468795152463, 6262.46769024638, 6172.290186628596, 6220.782272620618, 6239.1577137085915, 6248.843778905381, 6271.717772700148, 5542.584306176972, 5883.646981181143, 5888.705564721832, 6019.0, 6086.6348019119, 5164.9741751291, 5446.373667028184, 6049.213602231857, 6120.660465672032, 6133.601315914451, 4892.92660610084, 5819.854503637443, 5991.071383935497, 5997.070454079625, 6009.399060093956], "value": 5750.948034919473, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.4284373111745, 472.97398643074627, 520.1833121998461, 554.7559074007437, 594.1651978969544, 39119.80440097799, 42416.9395765106, 42514.57485425145, 42558.57441425585, 42710.7864460678, 36206.63793362066, 43694.0, 43990.780046099804, 43994.34008489867, 44043.77978110105, 9774.16919561838, 9944.5524951377, 9954.701358959242, 9976.251781116409, 9978.850317245247, 9837.163841073518, 9918.355306905065, 9936.205103591696, 9943.90056099437, 9968.700938971842, 9880.209583233323, 9930.900690993107, 9961.75095622608, 9975.301728878982, 9985.90014099857, 9897.356671816346, 9941.502924853728, 9944.254180936387, 9951.651692190811, 9956.452395118265, 9827.90172098277, 9854.605815767361, 9897.505124743733, 9900.90099099007, 9928.404295742279, 41787.955301117414, 42134.78932605348, 42145.946351341154, 42176.78911605422, 42305.57694423047, 3258.3809076275434, 3416.367971925202, 3629.872954446582, 3834.2331533693373, 4119.320312148492, 31083.68916310853, 31620.0, 32001.51997720036, 32399.190020249447, 32680.0, 3211.807291562514, 3253.5933008373954, 3312.03950854252, 3319.3527262183884, 3405.7105146062613, 521527.0, 524904.0, 526654.9999999962, 527129.0, 528344.0, 64911.0, 65236.34763652303, 65433.345666543675, 65571.0, 65592.0, 35654.0, 36085.09787255339, 36785.81607091947, 36901.81549092291, 37460.81269593634, 17479.475615731295, 17614.735778963324, 17628.735568966476, 17661.38185163513, 17723.556911077067, 13459.730805383837, 13540.187588744708, 13624.18254904709, 13642.86357136416, 13659.838913692447, 19685.01574921248, 19830.008499574964, 19890.60218795616, 20010.499737506678, 20021.399358019284, 8143.022837259567, 8152.796180095426, 8160.795980100545, 8207.343412526983, 8245.752627421187, 886.9334799890034, 1000.8098461292332, 1016.3901659004538, 1073.8335557988523, 1090.7600327927844, 29743.851280743456, 31731.365372692417, 31984.84007579947, 32147.196320091716, 32322.35355292881, 1003.3327836988467, 1027.2244455436098, 1050.6375300521308, 1059.6662051453768, 1083.9566417343217, 14112.788308175386, 17422.912885435744, 17446.65106697859, 17544.0, 18141.0, 559594.0, 706784.4660776663, 707910.0, 708232.0, 710765.0, 49741.502584973685, 60245.493862653784, 60363.0, 60618.0, 60816.0, 1343.946242150303, 1370.1778932640336, 1403.4736973634888, 1403.8104855844535, 1404.9789253161211, 24068.638970415108, 30935.0, 32927.83536082304, 33320.50019249762, 34085.82957085199, 53069.0, 53337.73331133475, 53481.66295842479, 53619.731901340245, 53658.463415365346, 620142.8921409366, 624836.0, 628663.0, 629058.8547057236, 631239.0, 27897.0, 28057.719422805512, 28391.858040709663, 28398.574021390108, 28414.43171136607, 47772.761136194094, 48077.0, 49273.753631231615, 49669.25496117489, 49689.50310496993, 33169.668303316656, 39689.60310396975, 41629.79185104055, 41809.74570762882, 42042.0, 40610.1877962445, 40673.59326406698, 40853.38719919144, 41545.0, 41784.79107604443, 34732.65267347395, 35578.64421355857, 39468.80265598654, 40315.79842100888, 42853.0, 34135.31729365449, 36262.29147607701, 36930.0, 36993.63006369902, 37076.44385334276, 20528.692069619265, 26379.0, 26510.602340965288, 26821.731782681924, 26847.926082956463], "value": 20552.207603245934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.53734160150975, 344.6760045557176, 375.42934739196403, 380.1522604591759, 383.6987964447909, 19354.0, 20106.296279630198, 20489.0, 20737.170513179455, 21006.0, 16663.41678041269, 16850.915745421287, 19876.60246795067, 20115.0, 20255.797442025574, 5385.3268341457315, 5769.0, 5804.767809287634, 6019.097135429677, 6073.453389194971, 5763.481286684198, 6016.157737916695, 6087.239095113111, 6127.203463549732, 6171.845703857394, 6004.429579189992, 6056.121862329959, 6088.969555152218, 6136.018237082068, 6137.447629713325, 6070.726817293233, 6140.263168419819, 6180.721867515973, 6192.225971753508, 6200.503959683215, 5781.710914454303, 5931.080682494177, 6050.062240352709, 6069.787557435468, 6070.908936365958, 12946.093773435863, 13123.540676076387, 13128.409221585052, 17672.558186045324, 24176.637350439756, 2334.1480359668767, 2334.9066037358484, 2404.603240465339, 2439.6462512935705, 2991.5512673098992, 7995.520268783892, 8081.353491720648, 9146.588403521857, 9694.854577181348, 10155.28912976092, 1814.401247588306, 1850.5466160790559, 1855.1002763659749, 1880.304287413652, 1904.2478221102726, 129050.0, 129274.0, 129609.0, 131899.0, 133583.0, 9285.953570232106, 11441.713957151138, 11682.0, 11737.823932641017, 11895.0, 14548.636284092983, 14762.557123286319, 14843.332050057774, 14852.0, 14856.405743770345, 8630.309575233967, 8718.564071796385, 8751.562421879007, 8783.824323513494, 8922.553872306358, 8634.050254472004, 8768.736937891874, 8823.0, 8986.775330616787, 9025.909740902507, 3696.5933747287777, 4470.0, 4479.59683628475, 4578.679492435497, 4679.883002924954, 1703.5485596316985, 1918.8368988635843, 1961.4704029911843, 1970.3694817658497, 1973.4178417366625, 860.423516244118, 939.9060093990684, 961.4856052012279, 1022.9028242316969, 1029.2280789407944, 19216.61566768657, 20316.467083824828, 20473.48816279605, 20558.38324850257, 20888.268910588056, 951.4006176109007, 963.6868017894212, 965.4979410706393, 986.921046316293, 998.1316254858319, 10322.380657160595, 10741.892581074246, 10858.34849909008, 10905.291156074829, 10908.0, 533940.0, 560928.0, 581535.0, 656214.0, 659672.0, 92004.0, 137748.0, 144182.0, 147923.52076479312, 148104.0, 950.2587981374539, 984.6947446291816, 994.9751256218652, 1000.229823036258, 1002.3033991376069, 18293.451196464128, 18834.0, 18869.056547172313, 18875.811241887404, 18935.621287574446, 52715.0, 56515.0, 56779.71610141923, 58086.7095664519, 58602.0, 59336.0, 65080.67459662671, 66091.67816643543, 67611.32388676248, 81814.59092704498, 7980.920190798018, 8014.879776803469, 8119.5534245617055, 8164.428490005643, 8258.29804466603, 10790.514426850654, 11253.549858005588, 12102.152849300817, 12531.248125112523, 12717.936410317889, 9036.864447033431, 10218.897811021794, 10302.433366164933, 10558.683239502827, 10743.570257189938, 9496.240300775784, 10421.06210441064, 10450.58197672115, 10455.843162352723, 10536.683899483029, 10652.147828173882, 10743.677689669323, 10778.29941053829, 10850.511726972463, 11057.502412391623, 6189.783357582463, 7931.127575966754, 8179.018517777667, 8298.83402331938, 8514.148585141436, 8148.266656000988, 10454.477276136011, 11192.88807111951, 11214.327140371604, 11216.943915280372], "value": 9399.434980795148, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1508.4946542908122, 1548.9612759681006, 1729.377424127314, 1833.669939410907, 1845.1512304339994, 8175.632096555654, 8437.831243375143, 8633.35249856261, 9197.586108625112, 9212.769680757985, 8629.352798540103, 8929.330300227493, 8933.731988040354, 9018.323625728064, 9019.23336516397, 2361.988190059047, 2374.287713685896, 2406.4585468269674, 2415.7342692303832, 2424.3939015246187, 2384.844985075973, 2404.7955923746504, 2429.2833614083797, 2431.8054555635595, 2432.428379330856, 2158.0, 2400.3879010852297, 2411.963820542693, 2420.2134306350417, 2438.0735320578156, 2381.357033600918, 2395.401149712572, 2402.087206861399, 2407.0010945457616, 2412.469256763518, 2384.6542251373453, 2403.65147053678, 2404.987975060131, 2406.3863714752624, 2411.867347295898, 8898.59956301968, 9035.774105647346, 9061.59222834974, 9064.501452420114, 9067.909320906772, 5328.92006619901, 5487.890242195173, 5500.037493438632, 5504.174373843915, 5506.284183056177, 3123.6251649801943, 3641.7814931104217, 3691.446283057536, 3717.8512859485586, 3750.5124333836425, 1107.4905543449943, 1114.921955463118, 1119.356370087195, 1119.9664010079712, 1143.2111842828422, 11922.880771192351, 12025.458854351575, 12119.93940030303, 12128.878711212863, 12147.08896832741, 4474.664400169935, 4618.445786505641, 4726.858194254178, 4765.785539650724, 4771.73755443447, 9201.4479131251, 9336.953315233517, 9352.625894964262, 9355.0, 9363.063693630582, 4689.132510485571, 5123.590112790967, 5272.420033796279, 5344.064788662046, 5379.897121090167, 3813.733038687321, 4490.753008584494, 4832.734199618984, 4969.0, 4989.501049894981, 3848.807559622008, 3871.128995975883, 3970.2059588082498, 3993.560708322082, 4014.0767623446186, 1191.5293459083787, 1196.5393323570313, 1200.5257923120319, 1209.232137592635, 1211.981820272679, 718.7771790744886, 903.7198468474794, 925.6343744220995, 932.934694571387, 935.2050756856753, 4844.685095468853, 5857.062869940789, 5896.528277737856, 5898.882022359615, 6202.782902598387, 449.13093164725706, 451.2869665927826, 452.77587594141113, 465.2509459769768, 468.3466564143001, 4010.9197816044098, 4032.0927791247323, 4043.110515686544, 4063.959360406417, 4086.7956602169775, 8951.73144805657, 11122.833157502644, 11147.609833655782, 11166.665000050012, 11174.553017879194, 11063.668089957315, 11084.113270938306, 11088.722781930355, 11104.222704410775, 11131.554737810558, 6456.709448074848, 8366.623501942428, 8435.198656127657, 8474.406791524658, 8488.957555212308, 5259.684418934723, 5943.64338139713, 6076.3012253591405, 6160.398296442868, 6227.0, 9795.0, 9942.652007179713, 10167.7458063549, 10176.033276838689, 10233.232507562112, 10279.94860025695, 10434.06093451593, 10458.529366178387, 10506.894931050592, 10590.735231619272, 5923.259592550931, 7118.9644051779405, 7644.80887977805, 7751.689932402866, 7880.369570434237, 8579.713043043594, 8639.568021599021, 8676.305895528469, 8681.348898832739, 8685.828542864285, 7540.9622951884885, 7609.086909570887, 7615.504992175491, 7784.026996625422, 7882.605869706606, 7052.2242553318065, 7521.699132034657, 7573.431992600466, 7679.040119985002, 7741.651625676971, 6188.040853667689, 6393.456556192776, 6465.676716164267, 7015.333543313581, 7085.256048114874, 4232.682548808913, 5071.568916642127, 5186.351706036746, 5222.686638801684, 5236.764345604381, 5113.130767769414, 5143.794248230179, 5242.475752424727, 5251.684898906078, 5279.709615971158], "value": 4534.019493651597, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.30285255403095, 291.7913691710427, 301.9350839569492, 305.40903352013856, 317.9459491886379, 5374.811881584145, 5438.646487978289, 5627.155926611005, 5723.914141287879, 5738.7417566209515, 4787.8563643090765, 5300.946990530094, 5574.749136288867, 5608.186812912125, 5716.857078573038, 4137.448456828689, 4303.289957157065, 4309.5259521452535, 4327.697061205717, 4353.978230108845, 3804.7824696097123, 4145.253854306224, 4289.914201715964, 4344.891377715567, 4347.347897815322, 4205.516365617963, 4208.884645568926, 4238.262312451895, 4271.78641067947, 4288.592583704543, 4245.702800803945, 4254.787260636971, 4281.250781113293, 4292.5492823253735, 4318.740875547477, 2882.942341153186, 3523.9295214095832, 3615.529981102466, 3710.424884142962, 3736.580099562176, 5483.561315094783, 5489.941272022991, 5506.256655351516, 5528.419515950807, 5535.418781027975, 4530.909381812346, 4893.0, 4961.206207006861, 4984.900301993976, 4993.650444468889, 5062.784931616422, 5225.581953443753, 5465.699386533739, 5638.859028524279, 5960.7019649017375, 3426.468897320919, 4050.696197785178, 4078.3678529827926, 4085.530164031115, 4105.281575724266, 5545.639533430314, 5910.793122240744, 6224.595401298901, 6297.874042519124, 6303.621782693053, 3974.5826688197903, 4064.4919385076864, 4149.8962525937095, 4186.539480657125, 4205.179989902001, 4071.8395257352104, 4199.475065616798, 4217.472815898012, 4227.556106608762, 4245.787710614457, 4568.81724731007, 4892.804287828447, 4942.332785073969, 4974.602031837444, 4991.326170966946, 4784.808607655655, 4803.879903002383, 5516.586256030814, 5571.832845014656, 5925.4520556160405, 1223.3210568134593, 1295.3458503455884, 1333.5465941579716, 1392.6031081141825, 1394.716860488333, 822.3585603229491, 840.5587066789984, 846.221476241859, 851.7955690634203, 855.5209082913589, 4320.746983374849, 4560.0, 4637.7449240291435, 4822.903541929212, 4839.733814640158, 4475.1428157315, 4983.084895336269, 4991.727109587032, 5003.9241563064115, 5043.672161309503, 4287.213311347649, 4532.546745325441, 4658.5293956003, 4718.575328220477, 4742.5731684148595, 2484.714257860333, 2724.2372135802007, 2876.5828954801436, 3279.8032118072992, 3287.7041066304146, 6282.277538083087, 6420.935790642127, 6442.710078046499, 6495.253045899782, 6500.317466666026, 5388.595855310868, 6225.346338634378, 6256.43692067707, 6382.361763823674, 6417.812704649655, 6323.20959880015, 6446.967765161145, 6456.289808121103, 6489.935100648933, 6534.411902928759, 4955.571769832828, 5320.600954928474, 5812.157237200498, 5875.970620146872, 5981.192539007352, 5379.246905433164, 5478.479544443271, 5706.914396284142, 5766.145757849891, 6162.815115546541, 5425.0, 5955.553333499918, 6392.968035159794, 6516.967415162894, 6544.803655890331, 3594.8382322795014, 3799.8670046548236, 3837.771912987817, 3926.7251292409255, 3931.1351502669368, 5547.55619550443, 5967.254093238345, 6125.816225513242, 6195.747232702867, 6252.5935814171935, 5600.0, 5979.970100149645, 5996.970015149896, 6027.126066720213, 6129.693515324305, 5383.757730902197, 5568.582356323211, 5706.629069110494, 5876.647401155944, 5890.0, 4898.975505122452, 4998.350214472241, 5759.646483076557, 5853.590248682552, 5917.852053698692, 5221.459669397613, 5342.732863356894, 5840.0, 5914.172015917689, 5974.312954010345, 5582.358028826737, 5815.6914694193465, 5837.423895548093, 5875.3243377012195, 5890.381509941394], "value": 4241.153195936885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [687.8066554527896, 700.5446459801126, 721.96029218393, 783.0525064671747, 827.9586020698965, 15305.464308749197, 15313.310901009454, 15778.0, 15818.683626327467, 15854.048757074585, 14105.647358816035, 14127.434902603909, 14180.361883715232, 14199.787003194935, 14209.715805683905, 671.1778071861954, 694.0630149298457, 844.214880161448, 846.826400587878, 877.1754550722301, 877.5875338590852, 877.8902637170354, 882.8322618702458, 884.0982198157875, 886.0297973718767, 940.8776859008319, 944.263474489899, 945.2910317262053, 947.0434860790616, 947.6446332625266, 918.7427520294328, 931.2736065868634, 934.2339281788936, 935.7099299217231, 939.0093451408761, 684.384054351083, 691.2016620802981, 698.5913240754165, 699.8005568412977, 700.9193942696604, 14322.355494002795, 14723.558293251219, 14751.483698070624, 14756.70486590273, 15005.0, 11694.590689325832, 12026.338551379671, 12754.80867786984, 14422.783658245029, 15037.097774133477, 11773.352465614387, 11896.167268291223, 11979.640610781691, 12003.579874704343, 12039.09706771987, 3721.6464435878547, 3785.8296376663116, 3855.4987851579394, 3859.07382228266, 3983.382575700771, 91145.26564203085, 119413.0, 123435.0, 123576.9999999991, 125302.0, 9538.570764315484, 10999.34003959765, 11262.436878156059, 11332.830007549894, 11371.886281137247, 19499.31752388688, 23443.7655623445, 23470.0, 23652.0, 23720.64419033716, 8156.429049966564, 8223.95888020556, 8276.668933242603, 8293.95853020743, 8462.746117616482, 4402.3616575597, 4536.183486972311, 4587.0, 4606.493285738566, 4643.257078867365, 3640.672339489459, 3701.7408781385043, 3759.9060023499082, 3769.0577355661085, 3777.527809023872, 644.6486664767713, 655.4297760948006, 656.5371413153811, 671.3387313496203, 681.9113515242987, 536.6190005096425, 607.5959486941223, 656.8160914943824, 676.671814170127, 697.7034760226883, 9334.906650933539, 9637.18083962857, 9705.417674939526, 9764.414135151914, 9904.613354130428, 569.7407679505815, 635.3836778325017, 673.2526895146384, 680.3026897430075, 685.6126288646899, 4642.373279607277, 4721.0, 4736.834210802605, 4748.3114948332295, 4785.904281914342, 101765.49117254514, 142144.0, 151090.24454877657, 168180.0, 171772.0, 110030.0, 111449.0, 114765.42617287027, 127435.36282318529, 132102.33948830195, 68553.65723171452, 94691.0, 95048.0, 98605.50697246467, 102578.48710756548, 8520.403571749917, 8685.652573896974, 9783.26625503076, 10213.846792297973, 10306.381617102998, 36793.63206368009, 41933.37099943564, 42479.93800155021, 49698.01207951641, 57327.426725732206, 75412.24587754052, 84560.15439845523, 87229.0, 90606.0, 101721.0, 10904.563817447213, 11138.721531961766, 12167.634970950885, 12906.806397904227, 13596.524121655695, 13726.107802992774, 14083.295835208404, 14476.782848257495, 15774.842251577338, 15849.326925946985, 11301.26541774782, 12341.197822141532, 12364.56724014655, 13317.400716967953, 14842.332095055965, 11735.941320293345, 11947.701307467383, 11991.460384282555, 12128.939355303168, 14083.788743168656, 13445.46218151263, 13665.18008919468, 13782.0, 13949.721005579628, 13973.161610303414, 9879.456629885139, 9978.451185184884, 10702.789163250838, 10941.734249520636, 11231.941894803977, 11402.657920262405, 11573.884261157618, 11614.709632258922, 11639.304214299724, 11890.821637675268], "value": 7729.3889354259745, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 118.0, 118.0, 122.0, 118.0, 119.0, 119.0, 119.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 110.0, 119.0, 175.0, 112.0, 116.0, 113.0, 131.0, 142.0, 111.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 229.0, 219.0, 200.0, 195.0, 200.0, 195.0, 199.0, 205.0, 197.0], "value": 203.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 59.0, 86.0, 60.0, 58.0, 57.0, 58.0, 77.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 70.0, 88.0, 73.0, 68.0, 72.0, 89.0, 69.0, 71.0, 86.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 76.0, 135.0, 132.0, 93.0, 88.0, 89.0, 75.0, 106.0, 134.0], "value": 101.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 107.0, 125.0, 93.0], "value": 98.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 127.0, 118.0, 91.0, 92.0, 95.0, 91.0, 92.0, 138.0, 95.0], "value": 105.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 58.0, 50.0, 54.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 73.0, 66.0, 82.0, 78.0, 75.0, 92.0, 102.0, 104.0, 88.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 86.0, 85.0, 83.0, 86.0, 82.0, 83.0, 83.0, 85.0, 90.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 147.0, 153.0, 154.0, 143.0, 163.0, 156.0, 182.0, 139.0], "value": 151.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 157.0, 183.0, 165.0, 164.0, 169.0, 180.0, 194.0, 191.0, 229.0], "value": 179.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 66.0, 69.0, 60.0, 63.0, 64.0, 64.0, 65.0, 67.0, 61.0], "value": 64.8, "unit": "score"}]}]} 03:13:34 INFO - Return code: 0 03:13:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:13:34 ERROR - # TBPL SUCCESS # 03:13:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:34 INFO - 2016-09-27 03:13:34.532 screenresolution[2612:296941] starting screenresolution argv=screenresolution get 03:13:34 INFO - 2016-09-27 03:13:34.535 screenresolution[2612:296941] Display 0: 1600x1200x32@60 03:13:34 INFO - 2016-09-27 03:13:34.541 screenresolution[2613:296944] starting screenresolution argv=screenresolution list 03:13:34 INFO - Available Modes on Display 0 03:13:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:34 INFO - Intel Iris: 03:13:34 INFO - Chipset Model: Intel Iris 03:13:34 INFO - Type: GPU 03:13:34 INFO - Bus: Built-In 03:13:34 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:34 INFO - Vendor: Intel (0x8086) 03:13:34 INFO - Device ID: 0x0a2e 03:13:34 INFO - Revision ID: 0x0009 03:13:34 INFO - Displays: 03:13:34 INFO - Display: 03:13:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:34 INFO - Display Serial Number: 1600x1200 60 03:13:34 INFO - Main Display: Yes 03:13:34 INFO - Mirror: Off 03:13:34 INFO - Online: Yes 03:13:34 INFO - Rotation: Supported 03:13:34 INFO - Return code: 0 03:13:34 INFO - Running post-action listener: _resource_record_post_action 03:13:34 INFO - [mozharness: 2016-09-27 10:13:34.779315Z] Finished run-tests step (success) 03:13:34 INFO - Running post-run listener: _resource_record_post_run 03:13:34 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 1290240; Write bytes: 666121216; Read time: 9; Write time: 1902 03:13:34 INFO - TinderboxPrint: CPU usage
54.4% 03:13:34 INFO - TinderboxPrint: I/O read bytes / time
1,290,240 / 9 03:13:34 INFO - TinderboxPrint: I/O write bytes / time
666,121,216 / 1,902 03:13:34 INFO - TinderboxPrint: CPU idle
2,201.0 (45.6%) 03:13:34 INFO - TinderboxPrint: CPU system
980.9 (20.3%) 03:13:34 INFO - TinderboxPrint: CPU user
1,647.8 (34.1%) 03:13:34 INFO - TinderboxPrint: Swap in / out
363,335,680 / 0 03:13:34 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 357751296; Write bytes: 355792384; Read time: 27627; Write time: 705 03:13:34 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 446464; Write bytes: 299290112; Read time: 5; Write time: 1159 03:13:35 INFO - Running post-run listener: _upload_blobber_files 03:13:35 INFO - Blob upload gear active. 03:13:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:13:35 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 03:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:13:35 INFO - (blobuploader) - INFO - Open directory for files ... 03:13:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:13:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:36 INFO - (blobuploader) - INFO - Done attempting. 03:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:37 INFO - (blobuploader) - INFO - Done attempting. 03:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:13:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:13:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:13:42 INFO - (blobuploader) - INFO - Done attempting. 03:13:42 INFO - (blobuploader) - INFO - Iteration through files over. 03:13:42 INFO - Return code: 0 03:13:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:13:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:13:42 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aecaa1273934253a1f376e1a1a0b1b9c90d3745ab137cdb1ae2397d07de676993cbb8ad87f314cae34ccd7cf7e2f7a38e576985c7528b373a68a0b3ce903fdb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7139e31a27e1434f3e0d957406147506d1a6f24e9b1bb8f4e2071a454f5eda57e2b82c18a808de9a220bb84e6ad330eaf05111b4a5770c1322f9be8d923c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff26ef5bdae85145a8784fc9239a435cbfba99ab9a82eaa74069fde6ec7459d087db4b29b706d083d6b4ae84f0c9d679bc49f0d2a1dce9205b286baf8259179b"} 03:13:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:13:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:13:42 INFO - Contents: 03:13:42 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aecaa1273934253a1f376e1a1a0b1b9c90d3745ab137cdb1ae2397d07de676993cbb8ad87f314cae34ccd7cf7e2f7a38e576985c7528b373a68a0b3ce903fdb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7139e31a27e1434f3e0d957406147506d1a6f24e9b1bb8f4e2071a454f5eda57e2b82c18a808de9a220bb84e6ad330eaf05111b4a5770c1322f9be8d923c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff26ef5bdae85145a8784fc9239a435cbfba99ab9a82eaa74069fde6ec7459d087db4b29b706d083d6b4ae84f0c9d679bc49f0d2a1dce9205b286baf8259179b"} 03:13:42 INFO - Running post-run listener: copy_logs_to_upload_dir 03:13:42 INFO - Copying logs to upload dir... 03:13:42 INFO - mkdir: /builds/slave/test/build/upload/logs 03:13:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.749876 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-09-27 03:13:42.225631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:13:42.230691) ========= 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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aecaa1273934253a1f376e1a1a0b1b9c90d3745ab137cdb1ae2397d07de676993cbb8ad87f314cae34ccd7cf7e2f7a38e576985c7528b373a68a0b3ce903fdb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7139e31a27e1434f3e0d957406147506d1a6f24e9b1bb8f4e2071a454f5eda57e2b82c18a808de9a220bb84e6ad330eaf05111b4a5770c1322f9be8d923c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff26ef5bdae85145a8784fc9239a435cbfba99ab9a82eaa74069fde6ec7459d087db4b29b706d083d6b4ae84f0c9d679bc49f0d2a1dce9205b286baf8259179b"} build_url:https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011396 build_url: 'https://queue.taskcluster.net/v1/task/WB4KbY78RpCf8xLsNNZnDA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/aecaa1273934253a1f376e1a1a0b1b9c90d3745ab137cdb1ae2397d07de676993cbb8ad87f314cae34ccd7cf7e2f7a38e576985c7528b373a68a0b3ce903fdb1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27c7139e31a27e1434f3e0d957406147506d1a6f24e9b1bb8f4e2071a454f5eda57e2b82c18a808de9a220bb84e6ad330eaf05111b4a5770c1322f9be8d923c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ff26ef5bdae85145a8784fc9239a435cbfba99ab9a82eaa74069fde6ec7459d087db4b29b706d083d6b4ae84f0c9d679bc49f0d2a1dce9205b286baf8259179b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 03:13:42.264678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:13:42.264990) ========= 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.OUE8iHV1YU/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.rfNnlD3sQC/Listeners TMPDIR=/var/folders/9v/qk4jx18140v19wkr9dt7ppy400000w/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.005132 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 03:13:42.316838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:13:42.317556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 03:13:42.318166) ========= ========= Total master_lag: 0.20 =========