builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0319 starttime: 1467651015.5 results: success (0) buildid: 20160704074125 builduid: 709da44dfb6747f88321fcc03f3c45c9 revision: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:15.499166) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:15.499728) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:15.500045) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:15.524982) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:15.525397) ========= 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.3y653nJAof/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.nXPKh6aeX9/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-07-04 09:50:15-- 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% 8.30M=0.001s 2016-07-04 09:50:15 (8.30 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.459850 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:16.032920) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:16.033216) ========= 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.3y653nJAof/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.nXPKh6aeX9/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.020052 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:16.090017) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:16.090358) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3y653nJAof/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.nXPKh6aeX9/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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-07-04 09:50:16,169 truncating revision to first 12 chars 2016-07-04 09:50:16,169 Setting DEBUG logging. 2016-07-04 09:50:16,169 attempt 1/10 2016-07-04 09:50:16,169 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/02f60237d69a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 09:50:16,872 unpacking tar archive at: fx-team-02f60237d69a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.960393 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:17.077797) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:17.078076) ========= script_repo_revision: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:17.078452) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:17.078738) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:50:17.105585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-04 09:50:17.105896) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3y653nJAof/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.nXPKh6aeX9/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:50:17 INFO - MultiFileLogger online at 20160704 09:50:17 in /builds/slave/test 09:50:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:50:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:50:17 INFO - {'append_to_log': False, 09:50:17 INFO - 'base_work_dir': '/builds/slave/test', 09:50:17 INFO - 'blob_upload_branch': 'Fx-Team', 09:50:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:50:17 INFO - 'branch': 'Fx-Team', 09:50:17 INFO - 'buildbot_json_path': 'buildprops.json', 09:50:17 INFO - 'config_files': ('talos/mac_config.py',), 09:50:17 INFO - 'default_actions': ('clobber', 09:50:17 INFO - 'read-buildbot-config', 09:50:17 INFO - 'download-and-extract', 09:50:17 INFO - 'populate-webroot', 09:50:17 INFO - 'create-virtualenv', 09:50:17 INFO - 'install', 09:50:17 INFO - 'run-tests'), 09:50:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:50:17 INFO - 'download_minidump_stackwalk': True, 09:50:17 INFO - 'download_symbols': 'ondemand', 09:50:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:50:17 INFO - 'tooltool.py': '/tools/tooltool.py', 09:50:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:50:17 INFO - '/tools/misc-python/virtualenv.py')}, 09:50:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:50:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:50:17 INFO - 'installer_path': 'installer.exe', 09:50:17 INFO - 'log_level': 'info', 09:50:17 INFO - 'log_name': 'talos', 09:50:17 INFO - 'log_to_console': True, 09:50:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:50:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:50:17 INFO - 'opt_config_files': (), 09:50:17 INFO - 'pip_index': False, 09:50:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:17 INFO - 'cmd': ('bash', 09:50:17 INFO - '-c', 09:50:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:17 INFO - 'enabled': True, 09:50:17 INFO - 'halt_on_failure': False, 09:50:17 INFO - 'name': 'check_screen_resolution'},), 09:50:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:50:17 INFO - 'cmd': ('bash', 09:50:17 INFO - '-c', 09:50:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:50:17 INFO - 'enabled': True, 09:50:17 INFO - 'halt_on_failure': False, 09:50:17 INFO - 'name': 'check_screen_resolution'},), 09:50:17 INFO - 'run_cmd_checks_enabled': True, 09:50:17 INFO - 'sps_profile': False, 09:50:17 INFO - 'sps_profile_interval': 0, 09:50:17 INFO - 'suite': 'dromaeojs', 09:50:17 INFO - 'system_bits': '32', 09:50:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:50:17 INFO - 'title': 't-yosemite-r7-0319', 09:50:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:50:17 INFO - 'use_talos_json': True, 09:50:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:50:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:50:17 INFO - 'work_dir': 'build'} 09:50:17 INFO - ##### 09:50:17 INFO - ##### Running clobber step. 09:50:17 INFO - ##### 09:50:17 INFO - Running pre-action listener: _resource_record_pre_action 09:50:17 INFO - Running main action method: clobber 09:50:17 INFO - rmtree: /builds/slave/test/build 09:50:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:50:19 INFO - Running post-action listener: _resource_record_post_action 09:50:19 INFO - ##### 09:50:19 INFO - ##### Finished clobber step (success) 09:50:19 INFO - ##### 09:50:19 INFO - ##### 09:50:19 INFO - ##### Running read-buildbot-config step. 09:50:19 INFO - ##### 09:50:19 INFO - Running pre-action listener: _resource_record_pre_action 09:50:19 INFO - Running main action method: read_buildbot_config 09:50:19 INFO - Using buildbot properties: 09:50:19 INFO - { 09:50:19 INFO - "project": "", 09:50:19 INFO - "product": "firefox", 09:50:19 INFO - "script_repo_revision": "production", 09:50:19 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 09:50:19 INFO - "repository": "", 09:50:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 09:50:19 INFO - "buildid": "20160704074125", 09:50:19 INFO - "pgo_build": "False", 09:50:19 INFO - "basedir": "/builds/slave/test", 09:50:19 INFO - "buildnumber": 70, 09:50:19 INFO - "slavename": "t-yosemite-r7-0319", 09:50:19 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:50:19 INFO - "platform": "yosemite_r7", 09:50:19 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:50:19 INFO - "branch": "fx-team", 09:50:19 INFO - "repo_path": "integration/fx-team", 09:50:19 INFO - "revision": "02f60237d69a4061c0f3c499239b7c13a9c4eeb3", 09:50:19 INFO - "stage_platform": "macosx64", 09:50:19 INFO - "builduid": "709da44dfb6747f88321fcc03f3c45c9", 09:50:19 INFO - "slavebuilddir": "test" 09:50:19 INFO - } 09:50:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:50:19 INFO - Running post-action listener: _resource_record_post_action 09:50:19 INFO - ##### 09:50:19 INFO - ##### Finished read-buildbot-config step (success) 09:50:19 INFO - ##### 09:50:19 INFO - ##### 09:50:19 INFO - ##### Running download-and-extract step. 09:50:19 INFO - ##### 09:50:19 INFO - Running pre-action listener: _resource_record_pre_action 09:50:19 INFO - Running main action method: download_and_extract 09:50:19 INFO - mkdir: /builds/slave/test/build/tests 09:50:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:19 INFO - https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:50:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:50:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:50:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 09:50:34 INFO - Downloaded 1199 bytes. 09:50:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:50:34 INFO - Using the following test package requirements: 09:50:34 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:50:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:50:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:50:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'jsshell-mac.zip'], 09:50:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:50:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:50:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:50:34 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:50:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:50:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:50:34 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:50:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:50:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:34 INFO - https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:50:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:50:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:50:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:50:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:50:35 INFO - Downloaded 18795196 bytes. 09:50:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:50:38 INFO - Return code: 0 09:50:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:50:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:38 INFO - https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:50:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:50:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:50:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:50:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:50:48 INFO - Downloaded 18795196 bytes. 09:50:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:50:52 INFO - Return code: 0 09:50:52 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:52 INFO - https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:50:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:50:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:50:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:50:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:50:53 INFO - Downloaded 14403333 bytes. 09:50:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:50:53 INFO - Return code: 0 09:50: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:50:53 INFO - https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:50:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:50:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:50:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:50:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 09:50:56 INFO - Downloaded 112413669 bytes. 09:50:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:50:56 INFO - mkdir: /builds/slave/test/properties 09:50:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:50:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:50:56 INFO - Contents: 09:50:56 INFO - build_url:https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - Running post-action listener: set_extra_try_arguments 09:50:58 INFO - ##### 09:50:58 INFO - ##### Finished download-and-extract step (success) 09:50:58 INFO - ##### 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running populate-webroot step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: populate_webroot 09:50:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:50:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:50:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:50:58 INFO - '--tppagecycles', 09:50:58 INFO - '7'], 09:50:58 INFO - 'tests': ['tsvgm']}}, 09:50:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:50:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:50:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:50:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:50:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:50:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['damp', 'tps']}, 09:50:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['damp', 'tps']}, 09:50:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['dromaeo_dom']}, 09:50:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:50:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['basic_compositor_video']}, 09:50:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:50:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore', 09:50:58 INFO - 'tabpaint']}, 09:50:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore', 09:50:58 INFO - 'tabpaint']}, 09:50:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore', 09:50:58 INFO - 'tabpaint']}, 09:50:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore', 09:50:58 INFO - 'tabpaint']}, 09:50:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore', 09:50:58 INFO - 'tabpaint']}, 09:50:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['a11yr', 09:50:58 INFO - 'ts_paint', 09:50:58 INFO - 'tpaint', 09:50:58 INFO - 'sessionrestore', 09:50:58 INFO - 'sessionrestore_no_auto_restore', 09:50:58 INFO - 'tabpaint']}, 09:50:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['tsvgx', 09:50:58 INFO - 'tsvgr_opacity', 09:50:58 INFO - 'tart', 09:50:58 INFO - 'tscrollx', 09:50:58 INFO - 'cart']}, 09:50:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:50:58 INFO - 'tsvgr_opacity', 09:50:58 INFO - 'tart', 09:50:58 INFO - 'tscrollx', 09:50:58 INFO - 'cart']}, 09:50:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--disable-e10s'], 09:50:58 INFO - 'tests': ['tp5o']}, 09:50:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'tests': ['tp5o']}, 09:50:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--disable-e10s', 09:50:58 INFO - '--xperf_path', 09:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:58 INFO - 'tests': ['tp5n']}, 09:50:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:50:58 INFO - 'talos_options': ['--xperf_path', 09:50:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:50:58 INFO - 'tests': ['tp5n']}}, 09:50:58 INFO - 'talos.zip': {'path': '', 09:50:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:50:58 INFO - Running post-action listener: _resource_record_post_action 09:50:58 INFO - ##### 09:50:58 INFO - ##### Finished populate-webroot step (success) 09:50:58 INFO - ##### 09:50:58 INFO - ##### 09:50:58 INFO - ##### Running create-virtualenv step. 09:50:58 INFO - ##### 09:50:58 INFO - Running pre-action listener: _resource_record_pre_action 09:50:58 INFO - Running main action method: create_virtualenv 09:50:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:50:58 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 09:50:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:50:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:50:58 INFO - Using real prefix '/tools/python27' 09:50:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:50:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:51:01 INFO - Installing pip.................done. 09:51:01 INFO - Return code: 0 09:51:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:51:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:01 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:01 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 09:51:01 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 09:51:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:01 INFO - 'HOME': '/Users/cltbld', 09:51:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:01 INFO - 'LOGNAME': 'cltbld', 09:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:01 INFO - 'MOZ_NO_REMOTE': '1', 09:51:01 INFO - 'NO_EM_RESTART': '1', 09:51:01 INFO - 'PAGER': '/bin/cat', 09:51:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:01 INFO - 'PWD': '/builds/slave/test', 09:51:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:01 INFO - 'SHELL': '/bin/bash', 09:51:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:01 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:01 INFO - 'USER': 'cltbld', 09:51:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:01 INFO - 'XPC_FLAGS': '0x0', 09:51:01 INFO - 'XPC_SERVICE_NAME': '0', 09:51:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:02 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 09:51:02 INFO - Cleaning up... 09:51:02 INFO - Return code: 0 09:51:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:51:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:02 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:02 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 09:51:02 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 09:51:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:02 INFO - 'HOME': '/Users/cltbld', 09:51:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:02 INFO - 'LOGNAME': 'cltbld', 09:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:02 INFO - 'MOZ_NO_REMOTE': '1', 09:51:02 INFO - 'NO_EM_RESTART': '1', 09:51:02 INFO - 'PAGER': '/bin/cat', 09:51:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:02 INFO - 'PWD': '/builds/slave/test', 09:51:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:02 INFO - 'SHELL': '/bin/bash', 09:51:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:02 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:02 INFO - 'USER': 'cltbld', 09:51:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:02 INFO - 'XPC_FLAGS': '0x0', 09:51:02 INFO - 'XPC_SERVICE_NAME': '0', 09:51:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:02 INFO - Downloading/unpacking psutil>=3.1.1 09:51:02 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 09:51:02 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 09:51:02 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 09:51:02 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 09:51:02 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 09:51:02 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 09:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:51:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:05 INFO - Installing collected packages: psutil 09:51:05 INFO - Running setup.py install for psutil 09:51:05 INFO - building 'psutil._psutil_osx' extension 09:51:05 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 09:51:06 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 09:51:06 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 09:51:06 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 09:51:06 INFO - building 'psutil._psutil_posix' extension 09:51:06 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 09:51:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:51:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:51:06 INFO - ^ 09:51:06 INFO - 1 warning generated. 09:51:06 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 09:51:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:51:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:51:06 INFO - Successfully installed psutil 09:51:06 INFO - Cleaning up... 09:51:06 INFO - Return code: 0 09:51:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:06 INFO - 'HOME': '/Users/cltbld', 09:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:06 INFO - 'LOGNAME': 'cltbld', 09:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:06 INFO - 'MOZ_NO_REMOTE': '1', 09:51:06 INFO - 'NO_EM_RESTART': '1', 09:51:06 INFO - 'PAGER': '/bin/cat', 09:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:06 INFO - 'PWD': '/builds/slave/test', 09:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:06 INFO - 'SHELL': '/bin/bash', 09:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:06 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:06 INFO - 'USER': 'cltbld', 09:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:06 INFO - 'XPC_FLAGS': '0x0', 09:51:06 INFO - 'XPC_SERVICE_NAME': '0', 09:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:51:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:51:09 INFO - Installing collected packages: mozsystemmonitor 09:51:09 INFO - Running setup.py install for mozsystemmonitor 09:51:09 INFO - Successfully installed mozsystemmonitor 09:51:09 INFO - Cleaning up... 09:51:09 INFO - Return code: 0 09:51:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:51:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:51:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:09 INFO - 'HOME': '/Users/cltbld', 09:51:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:09 INFO - 'LOGNAME': 'cltbld', 09:51:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:09 INFO - 'MOZ_NO_REMOTE': '1', 09:51:09 INFO - 'NO_EM_RESTART': '1', 09:51:09 INFO - 'PAGER': '/bin/cat', 09:51:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:09 INFO - 'PWD': '/builds/slave/test', 09:51:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:09 INFO - 'SHELL': '/bin/bash', 09:51:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:09 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:09 INFO - 'USER': 'cltbld', 09:51:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:09 INFO - 'XPC_FLAGS': '0x0', 09:51:09 INFO - 'XPC_SERVICE_NAME': '0', 09:51:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:09 INFO - Downloading/unpacking jsonschema==2.5.1 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:51:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:51:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:51:12 INFO - warning: no files found matching '*.txt' 09:51:12 INFO - no previously-included directories found matching 'build' 09:51:12 INFO - no previously-included directories found matching 'dist' 09:51:12 INFO - no previously-included directories found matching '.git*' 09:51:12 INFO - Installing collected packages: jsonschema, functools32 09:51:12 INFO - Running setup.py install for functools32 09:51:13 INFO - warning: no files found matching '*.txt' 09:51:13 INFO - no previously-included directories found matching 'build' 09:51:13 INFO - no previously-included directories found matching 'dist' 09:51:13 INFO - no previously-included directories found matching '.git*' 09:51:13 INFO - Successfully installed jsonschema functools32 09:51:13 INFO - Cleaning up... 09:51:13 INFO - Return code: 0 09:51:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:51:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:13 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:13 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 09:51:13 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 09:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:13 INFO - 'HOME': '/Users/cltbld', 09:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:13 INFO - 'LOGNAME': 'cltbld', 09:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:13 INFO - 'MOZ_NO_REMOTE': '1', 09:51:13 INFO - 'NO_EM_RESTART': '1', 09:51:13 INFO - 'PAGER': '/bin/cat', 09:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:13 INFO - 'PWD': '/builds/slave/test', 09:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:13 INFO - 'SHELL': '/bin/bash', 09:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:13 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:13 INFO - 'USER': 'cltbld', 09:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:13 INFO - 'XPC_FLAGS': '0x0', 09:51:13 INFO - 'XPC_SERVICE_NAME': '0', 09:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:51:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:51:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:51:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:51:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:51:17 INFO - Downloading docopt-0.6.1.tar.gz 09:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:51:17 INFO - Installing collected packages: blobuploader, requests, docopt 09:51:17 INFO - Running setup.py install for blobuploader 09:51:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:51:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:51:17 INFO - Running setup.py install for requests 09:51:17 INFO - Running setup.py install for docopt 09:51:18 INFO - Successfully installed blobuploader requests docopt 09:51:18 INFO - Cleaning up... 09:51:18 INFO - Return code: 0 09:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:18 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:18 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 09:51:18 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 09:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:18 INFO - 'HOME': '/Users/cltbld', 09:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:18 INFO - 'LOGNAME': 'cltbld', 09:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:18 INFO - 'MOZ_NO_REMOTE': '1', 09:51:18 INFO - 'NO_EM_RESTART': '1', 09:51:18 INFO - 'PAGER': '/bin/cat', 09:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:18 INFO - 'PWD': '/builds/slave/test', 09:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:18 INFO - 'SHELL': '/bin/bash', 09:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:18 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:18 INFO - 'USER': 'cltbld', 09:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:18 INFO - 'XPC_FLAGS': '0x0', 09:51:18 INFO - 'XPC_SERVICE_NAME': '0', 09:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Horrrc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-QFBiXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-UBNvfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-_N_mBF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-W8Zhin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:18 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-TuCMEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-nMK1La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-vnYumL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-e3cVbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-L4TXUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-wfLh4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-8juIhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-YtudkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-TVTN4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-HH_6FN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:19 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-lKDTSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:20 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-eFvT9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:51:20 INFO - Running setup.py install for manifestparser 09:51:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:51:20 INFO - Running setup.py install for mozcrash 09:51:20 INFO - Running setup.py install for mozdebug 09:51:20 INFO - Running setup.py install for mozdevice 09:51:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:51:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:51:20 INFO - Running setup.py install for mozfile 09:51:20 INFO - Running setup.py install for mozhttpd 09:51:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Running setup.py install for mozinfo 09:51:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Running setup.py install for mozInstall 09:51:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Running setup.py install for mozleak 09:51:21 INFO - Running setup.py install for mozlog 09:51:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Running setup.py install for moznetwork 09:51:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:51:21 INFO - Running setup.py install for mozprocess 09:51:21 INFO - Running setup.py install for mozprofile 09:51:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:51:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:51:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:51:22 INFO - Running setup.py install for mozrunner 09:51:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:51:22 INFO - Running setup.py install for mozscreenshot 09:51:22 INFO - Running setup.py install for moztest 09:51:22 INFO - Running setup.py install for mozversion 09:51:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:51:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:51:22 INFO - Cleaning up... 09:51:22 INFO - Return code: 0 09:51:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:22 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:23 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:23 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 09:51:23 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 09:51:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:23 INFO - 'HOME': '/Users/cltbld', 09:51:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:23 INFO - 'LOGNAME': 'cltbld', 09:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:23 INFO - 'MOZ_NO_REMOTE': '1', 09:51:23 INFO - 'NO_EM_RESTART': '1', 09:51:23 INFO - 'PAGER': '/bin/cat', 09:51:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:23 INFO - 'PWD': '/builds/slave/test', 09:51:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:23 INFO - 'SHELL': '/bin/bash', 09:51:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:23 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:23 INFO - 'USER': 'cltbld', 09:51:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:23 INFO - 'XPC_FLAGS': '0x0', 09:51:23 INFO - 'XPC_SERVICE_NAME': '0', 09:51:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:51:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-SDndzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:51:23 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)) 09:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:51:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-HqgRzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:51:23 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)) 09:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:51:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-3J7CHb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:51:23 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)) 09:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:51:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-fhMO0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:51:23 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)) 09:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:51:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-nm997y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:51:23 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)) 09:51:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:51:23 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-XKuNQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-Tr6hgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-DXps2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-jyB3mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-AZVoHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-V_ODEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-QSgtxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-uoqjLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-0vSvBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:51:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-wPFkjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:51:24 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)) 09:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:51:24 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-NNCOCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:51:25 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)) 09:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:51:25 INFO - Running setup.py (path:/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/pip-9JFu7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:51:25 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)) 09:51:25 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)) 09:51:25 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)) 09:51:25 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)) 09:51:25 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)) 09:51:25 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)) 09:51:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:51:25 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 09:51:25 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 09:51:25 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 09:51:25 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 09:51:25 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 09:51:25 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 09:51:28 INFO - Downloading blessings-1.6.tar.gz 09:51:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:51:28 INFO - Installing collected packages: blessings 09:51:28 INFO - Running setup.py install for blessings 09:51:28 INFO - Successfully installed blessings 09:51:28 INFO - Cleaning up... 09:51:28 INFO - Return code: 0 09:51:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:51:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:28 INFO - Reading from file tmpfile_stdout 09:51:28 INFO - Current package versions: 09:51:28 INFO - blessings == 1.6 09:51:28 INFO - blobuploader == 1.2.4 09:51:28 INFO - docopt == 0.6.1 09:51:28 INFO - functools32 == 3.2.3-2 09:51:28 INFO - jsonschema == 2.5.1 09:51:28 INFO - manifestparser == 1.1 09:51:28 INFO - mozInstall == 1.12 09:51:28 INFO - mozcrash == 0.17 09:51:28 INFO - mozdebug == 0.1 09:51:28 INFO - mozdevice == 0.48 09:51:28 INFO - mozfile == 1.2 09:51:28 INFO - mozhttpd == 0.7 09:51:28 INFO - mozinfo == 0.9 09:51:28 INFO - mozleak == 0.1 09:51:28 INFO - mozlog == 3.2 09:51:28 INFO - moznetwork == 0.27 09:51:28 INFO - mozprocess == 0.22 09:51:28 INFO - mozprofile == 0.28 09:51:28 INFO - mozrunner == 6.11 09:51:28 INFO - mozscreenshot == 0.1 09:51:28 INFO - mozsystemmonitor == 0.3 09:51:28 INFO - moztest == 0.7 09:51:28 INFO - mozversion == 1.4 09:51:28 INFO - psutil == 3.1.1 09:51:28 INFO - requests == 1.2.3 09:51:28 INFO - wsgiref == 0.1.2 09:51:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:51:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:28 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:28 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 09:51:28 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 09:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:28 INFO - 'HOME': '/Users/cltbld', 09:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:28 INFO - 'LOGNAME': 'cltbld', 09:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:28 INFO - 'MOZ_NO_REMOTE': '1', 09:51:28 INFO - 'NO_EM_RESTART': '1', 09:51:28 INFO - 'PAGER': '/bin/cat', 09:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:28 INFO - 'PWD': '/builds/slave/test', 09:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:28 INFO - 'SHELL': '/bin/bash', 09:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:28 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:28 INFO - 'USER': 'cltbld', 09:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:28 INFO - 'XPC_FLAGS': '0x0', 09:51:28 INFO - 'XPC_SERVICE_NAME': '0', 09:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 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)) 09:51:29 INFO - Cleaning up... 09:51:29 INFO - Return code: 0 09:51:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:51:29 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 0x107b9ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c30618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f93c0557090>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, '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.3y653nJAof/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.nXPKh6aeX9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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 09:51:29 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 09:51:29 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 09:51:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:51:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:51:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:51:29 INFO - 'HOME': '/Users/cltbld', 09:51:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:51:29 INFO - 'LOGNAME': 'cltbld', 09:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:51:29 INFO - 'MOZ_NO_REMOTE': '1', 09:51:29 INFO - 'NO_EM_RESTART': '1', 09:51:29 INFO - 'PAGER': '/bin/cat', 09:51:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:51:29 INFO - 'PWD': '/builds/slave/test', 09:51:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:51:29 INFO - 'SHELL': '/bin/bash', 09:51:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:51:29 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:51:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:51:29 INFO - 'USER': 'cltbld', 09:51:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:51:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:51:29 INFO - 'XPC_FLAGS': '0x0', 09:51:29 INFO - 'XPC_SERVICE_NAME': '0', 09:51:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:51:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:51:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:51:29 INFO - Cleaning up... 09:51:29 INFO - Return code: 0 09:51:29 INFO - Running post-action listener: _resource_record_post_action 09:51:29 INFO - Running post-action listener: _start_resource_monitoring 09:51:29 INFO - Starting resource monitoring. 09:51:29 INFO - ##### 09:51:29 INFO - ##### Finished create-virtualenv step (success) 09:51:29 INFO - ##### 09:51:29 INFO - ##### 09:51:29 INFO - ##### Running install step. 09:51:29 INFO - ##### 09:51:29 INFO - Running pre-action listener: _resource_record_pre_action 09:51:29 INFO - Running main action method: install 09:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:51:29 INFO - Reading from file tmpfile_stdout 09:51:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:51:29 INFO - Reading from file tmpfile_stdout 09:51:29 INFO - Output received: 09:51:29 INFO - Usage: mozinstall [options] installer 09:51:29 INFO - Options: 09:51:29 INFO - -h, --help show this help message and exit 09:51:29 INFO - -d DEST, --destination=DEST 09:51:29 INFO - Directory to install application into. [default: 09:51:29 INFO - "/builds/slave/test"] 09:51:29 INFO - --app=APP Application being installed. [default: firefox] 09:51:29 INFO - mkdir: /builds/slave/test/build/application 09:51:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:51:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:52:04 INFO - Reading from file tmpfile_stdout 09:52:04 INFO - Output received: 09:52:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:52:04 INFO - Running post-action listener: _resource_record_post_action 09:52:04 INFO - ##### 09:52:04 INFO - ##### Finished install step (success) 09:52:04 INFO - ##### 09:52:04 INFO - ##### 09:52:04 INFO - ##### Running run-tests step. 09:52:04 INFO - ##### 09:52:04 INFO - Running pre-action listener: _resource_record_pre_action 09:52:04 INFO - Running main action method: run_tests 09:52:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:52:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:52:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:52:04 INFO - 2016-07-04 09:52:04.068 screenresolution[1976:12326] starting screenresolution argv=screenresolution get 09:52:04 INFO - 2016-07-04 09:52:04.071 screenresolution[1976:12326] Display 0: 1600x1200x32@60 09:52:04 INFO - 2016-07-04 09:52:04.076 screenresolution[1977:12328] starting screenresolution argv=screenresolution list 09:52:04 INFO - Available Modes on Display 0 09:52:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:52:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:52:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:52:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:52:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:52:04 INFO - Intel Iris: 09:52:04 INFO - Chipset Model: Intel Iris 09:52:04 INFO - Type: GPU 09:52:04 INFO - Bus: Built-In 09:52:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:52:04 INFO - Vendor: Intel (0x8086) 09:52:04 INFO - Device ID: 0x0a2e 09:52:04 INFO - Revision ID: 0x0009 09:52:04 INFO - Displays: 09:52:04 INFO - Display: 09:52:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:52:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:52:04 INFO - Display Serial Number: 1600x1200 60 09:52:04 INFO - Main Display: Yes 09:52:04 INFO - Mirror: Off 09:52:04 INFO - Online: Yes 09:52:04 INFO - Rotation: Supported 09:52:04 INFO - Return code: 0 09:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:52:04 INFO - Python 2.7.3 09:52:04 INFO - Return code: 0 09:52:04 INFO - grabbing minidump binary from tooltool 09:52: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:52:04 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 0x107affd30>, '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 0x107864db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107af7b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:52:04 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 09:52:04 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 09:52:04 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 09:52:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:52:04 INFO - Return code: 0 09:52:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:52:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:52:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:52:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:52:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0319 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:52:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3y653nJAof/Render', 09:52:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:52:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:52:04 INFO - 'HOME': '/Users/cltbld', 09:52:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:52:04 INFO - 'LOGNAME': 'cltbld', 09:52:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:52:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:52:04 INFO - 'MOZ_NO_REMOTE': '1', 09:52:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:52:04 INFO - 'NO_EM_RESTART': '1', 09:52:04 INFO - 'PAGER': '/bin/cat', 09:52:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:52:04 INFO - 'PWD': '/builds/slave/test', 09:52:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:52:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:52:04 INFO - 'SHELL': '/bin/bash', 09:52:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nXPKh6aeX9/Listeners', 09:52:04 INFO - 'TMPDIR': '/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/', 09:52:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:52:04 INFO - 'USER': 'cltbld', 09:52:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:52:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:52:04 INFO - 'XPC_FLAGS': '0x0', 09:52:04 INFO - 'XPC_SERVICE_NAME': '0', 09:52:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:52:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0319', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:52:04 INFO - mozversion application_buildid: 20160704074125 09:52:04 INFO - mozversion application_changeset: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 09:52:04 INFO - mozversion application_display_name: Nightly 09:52:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:52:04 INFO - mozversion application_name: Firefox 09:52:04 INFO - mozversion application_remotingname: firefox 09:52:04 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:52:04 INFO - mozversion application_vendor: Mozilla 09:52:04 INFO - mozversion application_version: 50.0a1 09:52:04 INFO - mozversion platform_buildid: 20160704074125 09:52:04 INFO - mozversion platform_changeset: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 09:52:04 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:52:04 INFO - mozversion platform_version: 50.0a1 09:52:04 INFO - using testdate: 1467651124 09:52:04 INFO - actual date: 1467651124 09:52:04 INFO - starting webserver on 'localhost:49381' 09:52:04 INFO - SUITE-START | Running 2 tests 09:52:04 INFO - TEST-START | dromaeo_css 09:52:04 INFO - operating with platform_type : mac_ 09:52:04 INFO - Initialising browser for dromaeo_css test... 09:52:04 INFO - TEST-INFO | started process 1987 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmplHmfkE/profile http://localhost:49381/getInfo.html) 09:52:06 INFO - PROCESS | 1987 | __metrics Screen width/height:1600/1200 09:52:06 INFO - PROCESS | 1987 | colorDepth:24 09:52:06 INFO - PROCESS | 1987 | Browser inner width/height: 1024/689 09:52:06 INFO - PROCESS | 1987 | __metrics 09:52:07 INFO - PROCESS | 1987 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:52:07 INFO - PROCESS | 1987 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:07 INFO - TEST-INFO | 1987: exit 0 09:52:07 INFO - Browser initialized. 09:52:07 INFO - Running cycle 1/1 for dromaeo_css test... 09:52:07 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmplHmfkE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:19 INFO - PROCESS | 1989 | RSS: Main: 243613696 09:52:19 INFO - PROCESS | 1989 | 09:53:10 INFO - PROCESS | 1989 | 1467651190870 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] 09:55:21 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49381/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49381/tests/dromaeo/cssquery-ext.html) 09:55:22 INFO - PROCESS | 1989 | RSS: Main: 378945536 09:55:22 INFO - PROCESS | 1989 | 09:58:25 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49381/tests/dromaeo/cssquery-ext.html (next: http://localhost:49381/tests/dromaeo/cssquery-jquery.html) 09:58:26 INFO - PROCESS | 1989 | RSS: Main: 381444096 09:58:26 INFO - PROCESS | 1989 | 10:01:28 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49381/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49381/tests/dromaeo/cssquery-mootools.html) 10:01:29 INFO - PROCESS | 1989 | RSS: Main: 371761152 10:01:29 INFO - PROCESS | 1989 | 10:04:32 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49381/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49381/tests/dromaeo/cssquery-prototype.html) 10:04:32 INFO - PROCESS | 1989 | RSS: Main: 372371456 10:04:32 INFO - PROCESS | 1989 | 10:07:36 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49381/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49381/tests/dromaeo/cssquery-yui.html) 10:07:36 INFO - PROCESS | 1989 | RSS: Main: 344514560 10:07:36 INFO - PROCESS | 1989 | 10:10:39 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49381/tests/dromaeo/cssquery-yui.html (next: http://localhost:49381/tests/dromaeo/cssquery-dojo.html) 10:10:40 INFO - PROCESS | 1989 | RSS: Main: 412266496 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | __start_tp_report 10:10:40 INFO - PROCESS | 1989 | _x_x_mozilla_page_load 10:10:40 INFO - PROCESS | 1989 | _x_x_mozilla_page_load_details 10:10:40 INFO - PROCESS | 1989 | |i|pagename|runs| 10:10:40 INFO - PROCESS | 1989 | |0;dojo.html;2914.82511049337;3329.8002119872804;3357.412452820757;3364.899053028407;3385.830708464576;4847.539483749047;5646.858828529289;5746.971265143674;5765.7981970631035;5769.221155144054;5801.042827933396;5852.736626851792;5946.613470124439;5990.820275391734;6029.427204415584;4830.951690483085;5149.382074151107;5193.740312984336;5270.762815673284;5307.2835167252315;5369.677819330833;5375.973120134394;5377.677339359631;5430.945690543103;5437.755301011464;5190.039842629126;5255.710935898524;5257.605679574047;5296.9735151324385;5348.010618035656;5210.088234558937;5229.189475631283;5276.261323414725;5302.6023048271145;5331.70675612845;5175.870603234912;5211.400688920785;5265.315508983846;5283.260343551906;5339.919901201485;5704.743286552115;5879.7648094076185;5910.67491287979;5931.436513531207;5955.672438015908;6194.38056194377;6201.410865967771;6213.751449941997;6226.657533835637;6273;6260.87478250437;6275.497960163176;6276.435120839146;6303.338149494283;6315.494760419156;5890.116482527612;5899.410058994066;5924.7333869975955;5927.673977931212;5935.999999999957;6208.72060757267;6212.689365531795;6222.28443728977;6243.719032643542;6249.187605611241;6276;6277.340879207709;6284.277308109626;6290.779822706183;6295.811125666238;5505.421930697219;5959.016762234182;6284.214473190851;6312.495000399957;6314.747410103636;5485.957668043059;5973.223480947449;6220.875582488325;6275.937240627627;6288.748450062038;6309.842253943688;6323.873522529524;6341.302456729756;6341.841453963595;6346.873062538723;5009.524095210949;5045.131209277277;5046.369203849519;5059.924101138486;5094.465081166498;4485.798139083749;4486.327050942319;4545.954540454553;4583.54164583539;4615.838445654453;5838.7080645967535;5866.70666466675;5880.382559831241;5888.676122813286;5902.822915312548;6198.907016394758;6303.2751233607805;6309.810705678837;6310.968445157745;6313.684315784192;5847.210626565445;5856.12158176277;5906.675132867734;5921.970390148022;5969.283685957626;5493.368262649767;5498.752556134984;5505.229267902497;5512.035393806068;5537.916931246034;5462.344518657707;6189.50483961282;6245.875082498415;6263.154474145932;6389.48884089281;6264.2796078451565;6267;6280.591761535486;6293.087502312231;6296.716647750954;6352.777652782131;6365.4589359903075;6367.299597044414;6370.872582548416;6393.7122829471855;6114.084479019511;6137.070562331885;6157.938420615916;6237.251529816451;6339.778107766206;6284.842878928063;6287.559870808999;6290.119383286252;6296.401841825019;6300.558960872695;6026.427489388501;6194.473469755121;6199.721012554536;6200.162977997912;6205;4943.2585112233455;6086.300075491198;6106.06632622643;6113.755449782137;6189.195404597373;5967.582269241111;6032.487238584594;6034.758609655564;6069.9089513656445;6090.878182436415;6046.758129674764;6150.10823430609;6162.075688646739;6174.228221472316;6178.351273116438;5980.760769569169;6073.149759033827;6099.085137229274;6101.237345331833;6102 10:10:40 INFO - PROCESS | 1989 | |1;ext.html;471.585005195428;502.9270755740418;520.0898427751437;534.3587694766281;557.3673880146033;30093;42228;43520.78239608801;43639.78180109095;46233.53766462334;44714.77642611782;44924.77537612316;45041;45106.872328191814;45233.09533809322;8810.030896601369;9707.22342212623;9909.306348555603;9912.702618921443;9915.652952146676;8755.212030917217;8994.955025224865;9005.099490051009;9006.549672516381;10383;11792.705182370424;12122.757544849097;12128.787121287845;12157.452914618863;12180.756384872342;11988.980936620397;12050.517979280818;12052.698682532875;12067.215630984047;12067.456964436622;8734.082921293237;10519.158467322595;11837.408129593487;11840.230385024946;11886.93017628409;42356;42575.7227283182;42684.573154268684;42814.57185428137;42818.14363712708;3410.8973849455665;3557.3063252665743;3571.982140089283;3605.513255710498;3710.8144592770254;25555.488890222092;25935.351616209744;30995.380092398027;32475.35049299001;33046.3390732184;3242.951355729666;3422.931541369159;3423.828808559587;3445.500402441632;3447.4828775683595;536824.315878422;540540;541468;542449;551833.999999996;61326.386736132066;62304.68847655733;62468.68765656143;62512.687436563436;62559;65402;65445;65520.67239663771;65564.67217663881;65600.01599976004;16754.827162098536;17011;17014.149292535323;17045.40341088081;17049;13177.143485673592;13264.933675331562;13274.070815043047;13288.136271142539;13309;14503.057301275383;16345.754813677566;16399;16436.6712665746;16450;7067.22260551339;7107.431405487549;7123.074000380021;7188.748393806191;7200.423966082701;847.8384613079996;890.9064548222473;969.4328817641617;1156.5836298932377;1184.4196343791652;24927.750722492907;29858.656360463832;30647.38705225883;31050.68949310478;31554.684453155634;977.1108291454884;1065.3965781498794;1105.2042529378834;1129.2151954391784;1201.1411840533885;15314.157721325211;16000.279987400594;16025.439109631106;16075.678486430206;16205.67588648244;381215;384149;386763;387239;388986;53044.73477632587;53446;61155.38844611586;61436.38563614396;61901;1293.4179619171223;1429.7783843504274;1449.6013596260902;1467.2810322941682;1478.3716920309041;25494.74505254924;33255.334893301515;33302.333953321286;33368.1657958553;33399.16502087467;56989.43010570007;57617.71191144017;57814.42185578259;57817.710911446855;57820;560716;619361;619816;620415;620831;24917;26196.345091372867;26717.06490272831;27235.910563577236;27307.180784576496;48699.269510958075;49850.501494984586;50018.99962000812;50217.24239651595;50905.74547127241;40373.394399084624;41698;41874;42703;42888.78555607202;41184.79407602943;41301.96745081397;41382.1723565533;41677;42698;39810;40353;40539.79730101331;40693.79653101716;40907.1818563633;34752.131196719274;35502.8224858874;36326.27347453089;36447;36796.81601591975;25747.742522574536;26041.479170416864;26051.478970420863;26130.477390452466;27060.72939270582 10:10:40 INFO - PROCESS | 1989 | |2;jquery.html;367.78852160008;388.73371740357857;396.67472672408627;399.6503059822657;418.8513077857361;11746.825317468249;15719.371225150995;20810.791892081073;21132.049057792377;21200.681989770128;20800.959952002417;21460.819654918974;21744.238951636697;21803.890980545115;21816.781832181674;5084.262781896623;5726.656400615976;5915.378885217055;5925.88148237035;5988.461038506533;5844.970775146118;5929.822105336825;5964;5966.791162309299;5966.79116230932;4999.600031997432;5581.469760372758;5819.650820950736;5830.7667693292215;5838.153467747175;5655.26481557399;5779.797707080253;5786.971065144689;5817.941820581804;5823.359430462646;4995.925061124086;5022.296878437021;5067.366579177603;5083.542481176712;5085.313482679828;25894.223173304832;26055.478890422273;26115.955361785505;26636.733632663618;26670.866645666647;2188.365374041526;2271.5229801741652;2299.241250387368;2309.145616122029;3014.532747424131;14695.33870975798;15776.368945242177;15955.361785528565;16347.673046539121;16420.42528511508;1787.8122797106378;1853.8794978326366;1862.0689655172414;1875.812418758127;1919.433767038727;64745.67627161881;74625.0105648333;81938.59030704868;94550;113581;9339.252859771203;9885.15976142036;10022.198224142052;10153;10735.355878647306;12392.56626018085;12457.75084498305;13024.47902083906;13568.457261709422;13588.660283492794;8657.350698697623;8705.347098967603;8770.736877893672;8812.735617931472;8851.911480885237;7010.298970102949;8762.430442021248;8773.912260877438;8869.645214191489;8914.55427228636;4521.412216411845;4596.655250856199;4621.514740952151;4655.11552804966;4657.6273898088075;1864.2915692036938;1895.8388536974512;1922.692369220946;1924.6054558815408;1928.7203355513373;895.359817730326;899.4603238057244;918.7473444802732;934.990650093504;976.6044751875502;19857.4114070874;20270.29053983133;20541;21613.34410758289;21888.697303645888;908.3006085314271;949.4493193947632;964.262339310428;1006.9093781559695;1007.1338648762058;10811.427550934422;11178.832317515244;11193.94403027996;11215.887841121648;11280.2667826591;613881;615659;617693.9115304395;620605;628190;135113;138100.30949845185;144363;149632.50367496186;153061;951.296040929707;993.0764389118045;1008.0524307151401;1008.1380419741016;1008.2186305613209;18816.811831882053;19095.331663391713;19210.615787683888;19251.614967700287;19262.614747704687;53346;54718.726406367714;56562.71718641545;57772.71113644405;58614.70692646509;64526.677366612865;82632;82709.17290827015;83144.16855831606;84196;7879.057269998479;8057.879131813144;8178.7955301117945;8363.540005299767;8384.371172162235;10894.782104358026;12847;13138.343082846011;13187.670308241986;13213.405396756976;10337.121344685786;11194.370106056165;11274.7745045097;11338.943305283421;11387.829182562102;8852.89338832646;10933.56265749361;11036.558537658724;11066.612668556561;11269.211155219384;11363.715907102058;11467;11533.135014874086;11627.069834413058;11668.008219301455;6205.348438413902;8049.959750201211;8111.797205069921;8313.875291870505;8346.707865224687;9175.357724959189;11517.308961462339;11692.590759323723;11716.70708232301;11898.524059037542 10:10:40 INFO - PROCESS | 1989 | |3;mootools.html;1371.3760239091214;1531.502261764926;1563.6083885342048;1757.6221112460819;1921.7405650237213;6814.727410903564;8668.34987375947;8923.509206993613;8945;9088;7488.812779680511;8718.825623487526;8831.558422078886;8919.598618062186;8926.330525210618;2104.2424727098232;2194.6049711052005;2377.8335516513853;2409.409694624819;2412.8311018228733;2168.056895250571;2310.5609934112463;2368.834181607288;2372.039324073753;2372.79831214347;2207.86752794832;2308.284431826139;2350.2596682045187;2352.7882490575844;2357.1396440299254;2107.1782005018053;2291.851029683082;2336.5910965581043;2354.682117914094;2377.7741114594087;2406.061635961976;2434.6348047792794;2439.256026911791;2439.2804122783823;2442.05980697431;8984.32617553686;9034.051424600388;9036.322275829274;9052.411593246483;9053.547322633842;5262.684238945675;5437.700926449043;5439.3200849893765;5448.945510544883;5449.3188351456065;3418.418868792311;3480.269143479872;3520.8767693130617;3538.663826936437;3742.7567208131386;1089.967300980972;1101.3281898042187;1108.157800071943;1111.7887601355717;1119.9048080913133;11969.521219151224;12011.39943002855;12080.275183489019;12131.818022729665;12146.089043321697;4666.766661666903;4788.832390866303;4803.489121276673;4889.682170658896;4967.205247160437;8499.36254780894;10204.4387558685;10224.182065434896;10227.7443063924;10229.590816367261;5458.399576046631;5461.972690136524;5472.2338872557875;5473.808416705396;5474.835754927359;4415.558444155623;4582.679212455096;4800.279958006327;4949.529794669501;4986.7257300848805;3283.6223834259367;4031.1534577738416;4092.4475195848777;4133.028738246569;4133.937990930139;1289.6517940156293;1291.728736965248;1292.3538230884558;1307.0523870194033;1311.54096066376;664.3754870421789;820.3396266005923;879.6349514951352;890.1009979920198;972.557486343712;6153.661548614869;6262;6274.1843560337775;6300.905486417708;6364.172657554488;867.8524650809378;953.726774755695;958.1328897347911;1001.1440218613127;1006.2754816532085;4041.151358214749;4157.251694694924;4197.664186865043;4211.305134652809;4271.700980931305;10725.731856703645;11102.555897764161;11201.327920324806;11236.55053797839;11273.887261127447;11183.273087249303;11186.272892261977;11208.439578021067;11210.607628732956;11217;7929.167437418988;8307.626156822958;8311.958440207882;8319.251267385964;8486.024107227624;6128.050152226412;6163.630182189083;6206.386339551659;6220.315765265907;6473.611583304828;9761.267904907303;10212.336198147097;10412.062914337746;10430.582776688847;10441.373517588969;10303.072723454925;10503.527341269813;10528.947355263175;10538.262321637412;10572.84140737905;7651.464397492122;7729.806754831175;7764.107127680389;7808.804779880548;7858.842823143619;6621.6689165540565;8477.533735644598;8555.358348123791;8564.828703426021;8569.357298202784;6268.279147897868;7556.848863022598;7638.236176382317;7715.691372345268;7836.568988705448;7526.887096693664;7677.577733224726;7701.075870895528;7754.883676744967;7796.454248202572;6016.608920420159;7190.777567813589;7294.671739771617;7295.781126566211;7303.342699156889;4450;4875.146849301429;5075.3148324975655;5257.710825904612;5266.236395722675;5210.6613070150315;5229.47705229474;5322.973385133049;5351.732413379394;5388.838334849804 10:10:40 INFO - PROCESS | 1989 | |4;prototype.html;312.33472703142303;313.80230454813466;320.39925140361817;324.0198399840481;327.108628986013;5354.30552918486;5563;5594.440555944404;5624.465675760806;5636.7745290188395;4667.556582124693;5094.006668699605;5114.43741188469;5584.692841893694;5606.411326810678;3918.686505079601;3954.5056867891512;3992.6805855531634;4158.958410415888;4213.346931225649;3444.207832198596;3804.923901521982;3809.3333666608373;4072.3891416287497;4191.895202619929;3723.90690232745;3881.4760007399063;4119.588041195886;4167.916641667165;4168.874933751992;2966.7774916881103;3934.586868378822;4119.567445418218;4133.173365326947;4179.2686279901045;3428.365752335826;3613.8915832524804;3615.4215325547784;3615.891523254307;3635.709143268532;4255.574382581839;5277.894442111136;5304.496072873071;5361.329833770778;5418.729063546846;3714.888553343404;4541.250693635546;4777.331173635694;4780.760961951889;4784.937639910425;4698.365720627706;5277.102892508245;5550.222968784374;5666.943330566683;5765.509931655814;3747.3442147624055;4014.3577027675433;4025.2754504189234;4054.1283624020975;4065.4308396824467;4723.394046024368;5355.491228333302;5596.4403559644115;5883;5906.9704651476895;3263.8368081595827;4040.6363427291685;4073.714839961174;4116.485439320085;4122.40225167349;3842.481265029185;4119.0937993641355;4138.772367519815;4141.730787498803;4175.457190565207;3987.980060099681;4238.915221695611;4785;4795.992841503324;4817.421909370828;4717.504662010508;5521.503064724194;5736.799212027559;5740.598158128974;5758.971205143947;1317.767887025634;1390.3604342002793;1423.5871597236892;1427.9214643194723;1431.398812498753;733.1495465260273;874.213208112691;883.4919921045424;893.093510087262;898.7842917699705;4337;5076.238564215323;5281.947180528223;5317.229001794718;5528.253685752372;5720.799772007959;5901.380355062656;5923.259592550931;5974.283086029617;6067.33148384189;4103.7742924138865;4559.088182363541;5180.067587834151;5320.707361095177;5572.944270557324;2582.070113058424;2997.1757766614355;3120.458279852384;3123.593932788723;3139.230888432303;4906.607471402351;5088.872778180576;6152.323244443108;6178.104174894615;6183.659898705614;5682.948654498931;6088.939110608926;6112.786052488231;6145.66198859067;6174.024312220046;5323.334583177103;5949.732262048132;6130.804493123887;6142.877142457126;6165.907511387422;5138.588912887035;5795.478406943395;5876.912771137353;6001.039833626599;6026.337102918587;4837.097741355159;4953.1579631463455;5857.163557869602;5884.499817515559;5889.352171261244;5072.30811499369;5525.535733030831;5992.340842507408;6177.6911154441195;6190.597611155261;3806.3338915690197;3936.1106668799707;3979.582143874967;4001.7598944063448;4011.7592944423427;5550.4449555044175;5709.885802283848;5938;5942.376050514807;5953.880922381441;5579.804706835242;5694;5707.687231936595;5764.538836892954;5778.422157784356;4888.535589119028;5143.045642655767;5694.700501121627;5738.876615652069;5873.177755114202;4630.166570017429;5696.743646535833;5706.885862282648;5772.884542309214;5774.56690748204;5827.883442331215;5835.44563266489;5851.94148058531;5860.238169037998;5916.994111001054;5570.777168913198;5665.178549110438;5673.489385955284;5763.279590051244;5797.188393624811 10:10:40 INFO - PROCESS | 1989 | |5;yui.html;754.5133388964117;779.3180966654174;784.3999340504512;816.2735165702529;824.6701319472212;14996.250187490623;15577.688446231068;16266.75599866;16279.267432965515;16287.918560407212;14532.564023079298;14772.261386930664;14796.778048329285;14806.925965370157;14846.1834599097;709.4041005555332;764.7973287078928;904.5386852705118;909.8089401225717;941.5951141009364;744.94040476762;927.2350310993423;931.5295775633296;933.9066093390641;934.6868798952326;988.5403287471361;988.5946761827652;990.3216296836654;992.4045572656385;992.9851052234222;773.4817672159638;869.3132425383939;981.6024510073431;988.002117860962;995.6166875752888;742.2985278911431;742.840289337795;743.9888401673979;744.8845428958521;745.437194917839;14819.851801481955;15203.315850786741;15210.08739475624;15219;15226.086434813946;13487.595372138852;13695.520656777064;13751.381187846471;13753.862461375358;13970.650733731636;12976.286304253263;13043.413046412934;13131;13267.535636252782;13575.253361065137;4585.793639286207;4655.092257009885;4660.836870709542;4742.620590352763;4826.686265392738;103615.96384036138;105511;109844;110183;111744;11192.38441885704;11195.740663972936;11263.380514071805;11464.828027579593;11683.415829208505;21765.45586360322;21838.89080554587;21871.781282187294;22173.445663858532;22667.773322266898;8057.919420805834;8060.556669383123;8090.595470226465;8100.83798324042;8276.420650554403;4484.850884399557;4494.033782736662;4617.607503362185;4643.3963584733765;4738.3129446230105;3566.7503274771034;3688.096416377951;3689.2437050405138;3691.667749902522;3699.2786406650443;493.73091665042637;674.7941877727341;685.8833998220315;688.18793823288;689.6999805084804;590.4774274766862;682.9897551536731;695.3220609905403;699.7166147710185;724.5616402076773;9047.457152570867;9266.166045055978;9555.952220238854;9641.866418315545;9821.508924553744;637.8564822914807;651.7165033210568;668.7124536449277;669.4242951062083;680.0683064202075;4090.8977275567754;4645.883852903705;4685.81256749733;4730.7448502363595;4783.234682450791;104876;130543.34728326298;155305;163060.18469907812;168964.84657467122;130499;130629.34685326513;133701.33149334192;141658;145524;102707;119200.2519836208;121317.3934130306;123514;128589;9079.364444488823;9150.313726470407;9174.816503669756;9196.172344488761;9321.766955825888;67817.66091169513;69796;69901.65049174722;70240.64879675569;70502;100387;102366.97633023873;102787.4860625722;102867.45698814673;103985;12217.633470995885;12314.13801033919;12339.259644421005;12427.93786031064;12989.935050324688;9933.900660993297;12216.816747748613;13259.602211933658;13876.947071644223;13924.860751392762;9559.522023898917;11289.98390144891;13550.525731599346;13717.519886804314;14240.430382784987;13959.371828267549;14275.928620356832;14313.069650472686;14642.85357146415;14664.926675366554;13823.654408639864;13890.930545347208;14160.504382346568;14392.352344144329;14403.567892963229;11028.889711102785;11278.943605281922;11326.943365283121;11359.48882300282;11392.48733806964;10935.641535647634;11444;11481.712957176138;11572.826407603725;11650.825237621273 10:10:40 INFO - PROCESS | 1989 | __end_tp_report 10:10:40 INFO - PROCESS | 1989 | __start_cc_report 10:10:40 INFO - PROCESS | 1989 | _x_x_mozilla_cycle_collect,1384 10:10:40 INFO - PROCESS | 1989 | __end_cc_report 10:10:40 INFO - PROCESS | 1989 | __startTimestamp1467652240206__endTimestamp 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | ------- Summary: start ------- 10:10:40 INFO - PROCESS | 1989 | Number of tests: 6 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | [#0] dojo.html Cycles:165 Average:5790.45 Median:6026.43 stddev:650.25 (10.8%) stddev-sans-first:611.86 10:10:40 INFO - PROCESS | 1989 | Values: 2914.8 3329.8 3357.4 3364.9 3385.8 4847.5 5646.9 5747.0 5765.8 5769.2 5801.0 5852.7 5946.6 5990.8 6029.4 4831.0 5149.4 5193.7 5270.8 5307.3 5369.7 5376.0 5377.7 5430.9 5437.8 5190.0 5255.7 5257.6 5297.0 5348.0 5210.1 5229.2 5276.3 5302.6 5331.7 5175.9 5211.4 5265.3 5283.3 5339.9 5704.7 5879.8 5910.7 5931.4 5955.7 6194.4 6201.4 6213.8 6226.7 6273.0 6260.9 6275.5 6276.4 6303.3 6315.5 5890.1 5899.4 5924.7 5927.7 5936.0 6208.7 6212.7 6222.3 6243.7 6249.2 6276.0 6277.3 6284.3 6290.8 6295.8 5505.4 5959.0 6284.2 6312.5 6314.7 5486.0 5973.2 6220.9 6275.9 6288.7 6309.8 6323.9 6341.3 6341.8 6346.9 5009.5 5045.1 5046.4 5059.9 5094.5 4485.8 4486.3 4546.0 4583.5 4615.8 5838.7 5866.7 5880.4 5888.7 5902.8 6198.9 6303.3 6309.8 6311.0 6313.7 5847.2 5856.1 5906.7 5922.0 5969.3 5493.4 5498.8 5505.2 5512.0 5537.9 5462.3 6189.5 6245.9 6263.2 6389.5 6264.3 6267.0 6280.6 6293.1 6296.7 6352.8 6365.5 6367.3 6370.9 6393.7 6114.1 6137.1 6157.9 6237.3 6339.8 6284.8 6287.6 6290.1 6296.4 6300.6 6026.4 6194.5 6199.7 6200.2 6205.0 4943.3 6086.3 6106.1 6113.8 6189.2 5967.6 6032.5 6034.8 6069.9 6090.9 6046.8 6150.1 6162.1 6174.2 6178.4 5980.8 6073.1 6099.1 6101.2 6102.0 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | [#1] ext.html Cycles:180 Average:66576.33 Median:388112.50 stddev:138764.44 (35.8%) stddev-sans-first:139064.95 10:10:40 INFO - PROCESS | 1989 | Values: 471.6 502.9 520.1 534.4 557.4 30093.0 42228.0 43520.8 43639.8 46233.5 44714.8 44924.8 45041.0 45106.9 45233.1 8810.0 9707.2 9909.3 9912.7 9915.7 8755.2 8995.0 9005.1 9006.5 10383.0 11792.7 12122.8 12128.8 12157.5 12180.8 11989.0 12050.5 12052.7 12067.2 12067.5 8734.1 10519.2 11837.4 11840.2 11886.9 42356.0 42575.7 42684.6 42814.6 42818.1 3410.9 3557.3 3572.0 3605.5 3710.8 25555.5 25935.4 30995.4 32475.4 33046.3 3243.0 3422.9 3423.8 3445.5 3447.5 536824.3 540540.0 541468.0 542449.0 551834.0 61326.4 62304.7 62468.7 62512.7 62559.0 65402.0 65445.0 65520.7 65564.7 65600.0 16754.8 17011.0 17014.1 17045.4 17049.0 13177.1 13264.9 13274.1 13288.1 13309.0 14503.1 16345.8 16399.0 16436.7 16450.0 7067.2 7107.4 7123.1 7188.7 7200.4 847.8 890.9 969.4 1156.6 1184.4 24927.8 29858.7 30647.4 31050.7 31554.7 977.1 1065.4 1105.2 1129.2 1201.1 15314.2 16000.3 16025.4 16075.7 16205.7 381215.0 384149.0 386763.0 387239.0 388986.0 53044.7 53446.0 61155.4 61436.4 61901.0 1293.4 1429.8 1449.6 1467.3 1478.4 25494.7 33255.3 33302.3 33368.2 33399.2 56989.4 57617.7 57814.4 57817.7 57820.0 560716.0 619361.0 619816.0 620415.0 620831.0 24917.0 26196.3 26717.1 27235.9 27307.2 48699.3 49850.5 50019.0 50217.2 50905.7 40373.4 41698.0 41874.0 42703.0 42888.8 41184.8 41302.0 41382.2 41677.0 42698.0 39810.0 40353.0 40539.8 40693.8 40907.2 34752.1 35502.8 36326.3 36447.0 36796.8 25747.7 26041.5 26051.5 26130.5 27060.7 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | [#2] jquery.html Cycles:180 Average:35366.37 Median:14842.70 stddev:103091.36 (694.6%) stddev-sans-first:103347.06 10:10:40 INFO - PROCESS | 1989 | Values: 367.8 388.7 396.7 399.7 418.9 11746.8 15719.4 20810.8 21132.0 21200.7 20801.0 21460.8 21744.2 21803.9 21816.8 5084.3 5726.7 5915.4 5925.9 5988.5 5845.0 5929.8 5964.0 5966.8 5966.8 4999.6 5581.5 5819.7 5830.8 5838.2 5655.3 5779.8 5787.0 5817.9 5823.4 4995.9 5022.3 5067.4 5083.5 5085.3 25894.2 26055.5 26116.0 26636.7 26670.9 2188.4 2271.5 2299.2 2309.1 3014.5 14695.3 15776.4 15955.4 16347.7 16420.4 1787.8 1853.9 1862.1 1875.8 1919.4 64745.7 74625.0 81938.6 94550.0 113581.0 9339.3 9885.2 10022.2 10153.0 10735.4 12392.6 12457.8 13024.5 13568.5 13588.7 8657.4 8705.3 8770.7 8812.7 8851.9 7010.3 8762.4 8773.9 8869.6 8914.6 4521.4 4596.7 4621.5 4655.1 4657.6 1864.3 1895.8 1922.7 1924.6 1928.7 895.4 899.5 918.7 935.0 976.6 19857.4 20270.3 20541.0 21613.3 21888.7 908.3 949.4 964.3 1006.9 1007.1 10811.4 11178.8 11193.9 11215.9 11280.3 613881.0 615659.0 617693.9 620605.0 628190.0 135113.0 138100.3 144363.0 149632.5 153061.0 951.3 993.1 1008.1 1008.1 1008.2 18816.8 19095.3 19210.6 19251.6 19262.6 53346.0 54718.7 56562.7 57772.7 58614.7 64526.7 82632.0 82709.2 83144.2 84196.0 7879.1 8057.9 8178.8 8363.5 8384.4 10894.8 12847.0 13138.3 13187.7 13213.4 10337.1 11194.4 11274.8 11338.9 11387.8 8852.9 10933.6 11036.6 11066.6 11269.2 11363.7 11467.0 11533.1 11627.1 11668.0 6205.3 8050.0 8111.8 8313.9 8346.7 9175.4 11517.3 11692.6 11716.7 11898.5 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | [#3] mootools.html Cycles:180 Average:5827.38 Median:4801.88 stddev:3298.54 (68.7%) stddev-sans-first:3290.80 10:10:40 INFO - PROCESS | 1989 | Values: 1371.4 1531.5 1563.6 1757.6 1921.7 6814.7 8668.3 8923.5 8945.0 9088.0 7488.8 8718.8 8831.6 8919.6 8926.3 2104.2 2194.6 2377.8 2409.4 2412.8 2168.1 2310.6 2368.8 2372.0 2372.8 2207.9 2308.3 2350.3 2352.8 2357.1 2107.2 2291.9 2336.6 2354.7 2377.8 2406.1 2434.6 2439.3 2439.3 2442.1 8984.3 9034.1 9036.3 9052.4 9053.5 5262.7 5437.7 5439.3 5448.9 5449.3 3418.4 3480.3 3520.9 3538.7 3742.8 1090.0 1101.3 1108.2 1111.8 1119.9 11969.5 12011.4 12080.3 12131.8 12146.1 4666.8 4788.8 4803.5 4889.7 4967.2 8499.4 10204.4 10224.2 10227.7 10229.6 5458.4 5462.0 5472.2 5473.8 5474.8 4415.6 4582.7 4800.3 4949.5 4986.7 3283.6 4031.2 4092.4 4133.0 4133.9 1289.7 1291.7 1292.4 1307.1 1311.5 664.4 820.3 879.6 890.1 972.6 6153.7 6262.0 6274.2 6300.9 6364.2 867.9 953.7 958.1 1001.1 1006.3 4041.2 4157.3 4197.7 4211.3 4271.7 10725.7 11102.6 11201.3 11236.6 11273.9 11183.3 11186.3 11208.4 11210.6 11217.0 7929.2 8307.6 8312.0 8319.3 8486.0 6128.1 6163.6 6206.4 6220.3 6473.6 9761.3 10212.3 10412.1 10430.6 10441.4 10303.1 10503.5 10528.9 10538.3 10572.8 7651.5 7729.8 7764.1 7808.8 7858.8 6621.7 8477.5 8555.4 8564.8 8569.4 6268.3 7556.8 7638.2 7715.7 7836.6 7526.9 7677.6 7701.1 7754.9 7796.5 6016.6 7190.8 7294.7 7295.8 7303.3 4450.0 4875.1 5075.3 5257.7 5266.2 5210.7 5229.5 5323.0 5351.7 5388.8 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | [#4] prototype.html Cycles:180 Average:4637.60 Median:5228.59 stddev:1443.06 (27.6%) stddev-sans-first:1410.12 10:10:40 INFO - PROCESS | 1989 | Values: 312.3 313.8 320.4 324.0 327.1 5354.3 5563.0 5594.4 5624.5 5636.8 4667.6 5094.0 5114.4 5584.7 5606.4 3918.7 3954.5 3992.7 4159.0 4213.3 3444.2 3804.9 3809.3 4072.4 4191.9 3723.9 3881.5 4119.6 4167.9 4168.9 2966.8 3934.6 4119.6 4133.2 4179.3 3428.4 3613.9 3615.4 3615.9 3635.7 4255.6 5277.9 5304.5 5361.3 5418.7 3714.9 4541.3 4777.3 4780.8 4784.9 4698.4 5277.1 5550.2 5666.9 5765.5 3747.3 4014.4 4025.3 4054.1 4065.4 4723.4 5355.5 5596.4 5883.0 5907.0 3263.8 4040.6 4073.7 4116.5 4122.4 3842.5 4119.1 4138.8 4141.7 4175.5 3988.0 4238.9 4785.0 4796.0 4817.4 4717.5 5521.5 5736.8 5740.6 5759.0 1317.8 1390.4 1423.6 1427.9 1431.4 733.1 874.2 883.5 893.1 898.8 4337.0 5076.2 5281.9 5317.2 5528.3 5720.8 5901.4 5923.3 5974.3 6067.3 4103.8 4559.1 5180.1 5320.7 5572.9 2582.1 2997.2 3120.5 3123.6 3139.2 4906.6 5088.9 6152.3 6178.1 6183.7 5682.9 6088.9 6112.8 6145.7 6174.0 5323.3 5949.7 6130.8 6142.9 6165.9 5138.6 5795.5 5876.9 6001.0 6026.3 4837.1 4953.2 5857.2 5884.5 5889.4 5072.3 5525.5 5992.3 6177.7 6190.6 3806.3 3936.1 3979.6 4001.8 4011.8 5550.4 5709.9 5938.0 5942.4 5953.9 5579.8 5694.0 5707.7 5764.5 5778.4 4888.5 5143.0 5694.7 5738.9 5873.2 4630.2 5696.7 5706.9 5772.9 5774.6 5827.9 5835.4 5851.9 5860.2 5917.0 5570.8 5665.2 5673.5 5763.3 5797.2 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - PROCESS | 1989 | [#5] yui.html Cycles:180 Average:25741.91 Median:22022.61 stddev:41180.18 (187.0%) stddev-sans-first:41252.96 10:10:40 INFO - PROCESS | 1989 | Values: 754.5 779.3 784.4 816.3 824.7 14996.3 15577.7 16266.8 16279.3 16287.9 14532.6 14772.3 14796.8 14806.9 14846.2 709.4 764.8 904.5 909.8 941.6 744.9 927.2 931.5 933.9 934.7 988.5 988.6 990.3 992.4 993.0 773.5 869.3 981.6 988.0 995.6 742.3 742.8 744.0 744.9 745.4 14819.9 15203.3 15210.1 15219.0 15226.1 13487.6 13695.5 13751.4 13753.9 13970.7 12976.3 13043.4 13131.0 13267.5 13575.3 4585.8 4655.1 4660.8 4742.6 4826.7 103616.0 105511.0 109844.0 110183.0 111744.0 11192.4 11195.7 11263.4 11464.8 11683.4 21765.5 21838.9 21871.8 22173.4 22667.8 8057.9 8060.6 8090.6 8100.8 8276.4 4484.9 4494.0 4617.6 4643.4 4738.3 3566.8 3688.1 3689.2 3691.7 3699.3 493.7 674.8 685.9 688.2 689.7 590.5 683.0 695.3 699.7 724.6 9047.5 9266.2 9556.0 9641.9 9821.5 637.9 651.7 668.7 669.4 680.1 4090.9 4645.9 4685.8 4730.7 4783.2 104876.0 130543.3 155305.0 163060.2 168964.8 130499.0 130629.3 133701.3 141658.0 145524.0 102707.0 119200.3 121317.4 123514.0 128589.0 9079.4 9150.3 9174.8 9196.2 9321.8 67817.7 69796.0 69901.7 70240.6 70502.0 100387.0 102367.0 102787.5 102867.5 103985.0 12217.6 12314.1 12339.3 12427.9 12989.9 9933.9 12216.8 13259.6 13876.9 13924.9 9559.5 11290.0 13550.5 13717.5 14240.4 13959.4 14275.9 14313.1 14642.9 14664.9 13823.7 13890.9 14160.5 14392.4 14403.6 11028.9 11278.9 11326.9 11359.5 11392.5 10935.6 11444.0 11481.7 11572.8 11650.8 10:10:40 INFO - PROCESS | 1989 | -------- Summary: end -------- 10:10:40 INFO - PROCESS | 1989 | 10:10:40 INFO - TEST-INFO | 1989: exit 0 10:10:40 INFO - TEST-OK | dromaeo_css | took 1116123ms 10:10:40 INFO - TEST-START | kraken 10:10:40 INFO - operating with platform_type : mac_ 10:10:40 INFO - Initialising browser for kraken test... 10:10:40 INFO - TEST-INFO | started process 1991 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpuxpgeJ/profile http://localhost:49381/getInfo.html) 10:10:43 INFO - PROCESS | 1991 | __metrics Screen width/height:1600/1200 10:10:43 INFO - PROCESS | 1991 | colorDepth:24 10:10:43 INFO - PROCESS | 1991 | Browser inner width/height: 1024/689 10:10:43 INFO - PROCESS | 1991 | __metrics 10:10:43 INFO - PROCESS | 1991 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:10:43 INFO - PROCESS | 1991 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:10:43 INFO - TEST-INFO | 1991: exit 0 10:10:43 INFO - Browser initialized. 10:10:43 INFO - Running cycle 1/1 for kraken test... 10:10:43 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/tmpuxpgeJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:10:55 INFO - PROCESS | 1992 | RSS: Main: 244842496 10:10:55 INFO - PROCESS | 1992 | 10:10:58 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49381/tests/kraken/driver.html?testName=audio-beat-detection) 10:10:59 INFO - PROCESS | 1992 | RSS: Main: 294522880 10:10:59 INFO - PROCESS | 1992 | 10:11:02 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49381/tests/kraken/driver.html?testName=audio-dft) 10:11:02 INFO - PROCESS | 1992 | RSS: Main: 304775168 10:11:02 INFO - PROCESS | 1992 | 10:11:06 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49381/tests/kraken/driver.html?testName=audio-fft) 10:11:06 INFO - PROCESS | 1992 | RSS: Main: 391372800 10:11:06 INFO - PROCESS | 1992 | 10:11:08 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49381/tests/kraken/driver.html?testName=audio-oscillator) 10:11:09 INFO - PROCESS | 1992 | RSS: Main: 292802560 10:11:09 INFO - PROCESS | 1992 | 10:11:11 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49381/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:11:12 INFO - PROCESS | 1992 | RSS: Main: 296366080 10:11:12 INFO - PROCESS | 1992 | 10:11:15 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49381/tests/kraken/driver.html?testName=imaging-darkroom) 10:11:15 INFO - PROCESS | 1992 | RSS: Main: 335597568 10:11:15 INFO - PROCESS | 1992 | 10:11:18 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49381/tests/kraken/driver.html?testName=imaging-desaturate) 10:11:19 INFO - PROCESS | 1992 | RSS: Main: 334938112 10:11:19 INFO - PROCESS | 1992 | 10:11:22 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49381/tests/kraken/driver.html?testName=json-parse-financial) 10:11:22 INFO - PROCESS | 1992 | RSS: Main: 334974976 10:11:22 INFO - PROCESS | 1992 | 10:11:24 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49381/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:11:24 INFO - PROCESS | 1992 | RSS: Main: 312152064 10:11:24 INFO - PROCESS | 1992 | 10:11:26 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:11:27 INFO - PROCESS | 1992 | RSS: Main: 319123456 10:11:27 INFO - PROCESS | 1992 | 10:11:29 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:11:30 INFO - PROCESS | 1992 | RSS: Main: 318369792 10:11:30 INFO - PROCESS | 1992 | 10:11:33 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:11:33 INFO - PROCESS | 1992 | RSS: Main: 326619136 10:11:33 INFO - PROCESS | 1992 | 10:11:36 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:11:37 INFO - PROCESS | 1992 | RSS: Main: 329412608 10:11:37 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | Cycle 1(1): loaded http://localhost:49381/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49381/tests/kraken/driver.html?testName=ai-astar) 10:11:39 INFO - PROCESS | 1992 | RSS: Main: 372699136 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | __start_tp_report 10:11:39 INFO - PROCESS | 1992 | _x_x_mozilla_page_load 10:11:39 INFO - PROCESS | 1992 | _x_x_mozilla_page_load_details 10:11:39 INFO - PROCESS | 1992 | |i|pagename|runs| 10:11:39 INFO - PROCESS | 1992 | |0;ai-astar;104;112;113;113;114;112;113;112;112;113 10:11:39 INFO - PROCESS | 1992 | |1;audio-beat-detection;144;113;113;200;139;118;128;108;142;106 10:11:39 INFO - PROCESS | 1992 | |2;audio-dft;183;184;186;185;186;218;184;180;183;182 10:11:39 INFO - PROCESS | 1992 | |3;audio-fft;79;74;56;106;56;56;66;59;94;55 10:11:39 INFO - PROCESS | 1992 | |4;audio-oscillator;82;86;90;71;73;80;130;100;76;99 10:11:39 INFO - PROCESS | 1992 | |5;imaging-gaussian-blur;87;100;111;129;122;84;89;85;90;86 10:11:39 INFO - PROCESS | 1992 | |6;imaging-darkroom;92;92;93;93;100;97;92;93;93;92 10:11:39 INFO - PROCESS | 1992 | |7;imaging-desaturate;84;87;85;84;83;84;86;84;84;85 10:11:39 INFO - PROCESS | 1992 | |8;json-parse-financial;56;53;50;53;53;54;53;51;52;52 10:11:39 INFO - PROCESS | 1992 | |9;json-stringify-tinderbox;65;76;78;71;72;68;70;71;71;71 10:11:39 INFO - PROCESS | 1992 | |10;stanford-crypto-aes;86;82;81;85;83;84;81;86;93;103 10:11:39 INFO - PROCESS | 1992 | |11;stanford-crypto-ccm;138;136;135;161;153;142;131;138;221;137 10:11:39 INFO - PROCESS | 1992 | |12;stanford-crypto-pbkdf2;162;162;162;160;157;162;168;221;203;160 10:11:39 INFO - PROCESS | 1992 | |13;stanford-crypto-sha256-iterative;68;68;66;67;66;66;65;64;65;65 10:11:39 INFO - PROCESS | 1992 | __end_tp_report 10:11:39 INFO - PROCESS | 1992 | __start_cc_report 10:11:39 INFO - PROCESS | 1992 | _x_x_mozilla_cycle_collect,1991 10:11:39 INFO - PROCESS | 1992 | __end_cc_report 10:11:39 INFO - PROCESS | 1992 | __startTimestamp1467652299314__endTimestamp 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | ------- Summary: start ------- 10:11:39 INFO - PROCESS | 1992 | Number of tests: 14 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 10:11:39 INFO - PROCESS | 1992 | Values: 104.0 112.0 113.0 113.0 114.0 112.0 113.0 112.0 112.0 113.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:133.50 stddev:28.08 (21.0%) stddev-sans-first:29.39 10:11:39 INFO - PROCESS | 1992 | Values: 144.0 113.0 113.0 200.0 139.0 118.0 128.0 108.0 142.0 106.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#2] audio-dft Cycles:10 Average:187.10 Median:184.50 stddev:11.01 (6.0%) stddev-sans-first:11.58 10:11:39 INFO - PROCESS | 1992 | Values: 183.0 184.0 186.0 185.0 186.0 218.0 184.0 180.0 183.0 182.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#3] audio-fft Cycles:10 Average:70.10 Median:62.50 stddev:18.01 (28.8%) stddev-sans-first:18.81 10:11:39 INFO - PROCESS | 1992 | Values: 79.0 74.0 56.0 106.0 56.0 56.0 66.0 59.0 94.0 55.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:81.00 stddev:17.61 (21.7%) stddev-sans-first:18.51 10:11:39 INFO - PROCESS | 1992 | Values: 82.0 86.0 90.0 71.0 73.0 80.0 130.0 100.0 76.0 99.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#5] imaging-gaussian-blur Cycles:10 Average:98.30 Median:85.50 stddev:16.61 (19.4%) stddev-sans-first:17.11 10:11:39 INFO - PROCESS | 1992 | Values: 87.0 100.0 111.0 129.0 122.0 84.0 89.0 85.0 90.0 86.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#6] imaging-darkroom Cycles:10 Average:93.70 Median:93.00 stddev:2.67 (2.9%) stddev-sans-first:2.76 10:11:39 INFO - PROCESS | 1992 | Values: 92.0 92.0 93.0 93.0 100.0 97.0 92.0 93.0 93.0 92.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:84.50 stddev:1.17 (1.4%) stddev-sans-first:1.22 10:11:39 INFO - PROCESS | 1992 | Values: 84.0 87.0 85.0 84.0 83.0 84.0 86.0 84.0 84.0 85.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:1.64 (3.1%) stddev-sans-first:1.22 10:11:39 INFO - PROCESS | 1992 | Values: 56.0 53.0 50.0 53.0 53.0 54.0 53.0 51.0 52.0 52.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.00 stddev:3.65 (5.1%) stddev-sans-first:3.08 10:11:39 INFO - PROCESS | 1992 | Values: 65.0 76.0 78.0 71.0 72.0 68.0 70.0 71.0 71.0 71.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:84.50 stddev:6.80 (8.0%) stddev-sans-first:7.21 10:11:39 INFO - PROCESS | 1992 | Values: 86.0 82.0 81.0 85.0 83.0 84.0 81.0 86.0 93.0 103.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#11] stanford-crypto-ccm Cycles:10 Average:149.20 Median:140.00 stddev:26.81 (19.1%) stddev-sans-first:28.13 10:11:39 INFO - PROCESS | 1992 | Values: 138.0 136.0 135.0 161.0 153.0 142.0 131.0 138.0 221.0 137.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:162.00 stddev:21.83 (13.5%) stddev-sans-first:22.87 10:11:39 INFO - PROCESS | 1992 | Values: 162.0 162.0 162.0 160.0 157.0 162.0 168.0 221.0 203.0 160.0 10:11:39 INFO - PROCESS | 1992 | 10:11:39 INFO - PROCESS | 1992 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.33 (2.0%) stddev-sans-first:1.20 10:11:39 INFO - PROCESS | 1992 | Values: 68.0 68.0 66.0 67.0 66.0 66.0 65.0 64.0 65.0 65.0 10:11:39 INFO - PROCESS | 1992 | -------- Summary: end -------- 10:11:39 INFO - PROCESS | 1992 | 10:11:40 INFO - TEST-INFO | 1992: exit 0 10:11:40 INFO - TEST-OK | kraken | took 59328ms 10:11:40 INFO - SUITE-END | took 1175s 10:11:40 INFO - Completed test suite (00:19:35) 10:11:40 INFO - javascript benchmark 10:11:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2914.82511049337, 3329.8002119872804, 3357.412452820757, 3364.899053028407, 3385.830708464576, 4847.539483749047, 5646.858828529289, 5746.971265143674, 5765.7981970631035, 5769.221155144054, 5801.042827933396, 5852.736626851792, 5946.613470124439, 5990.820275391734, 6029.427204415584, 4830.951690483085, 5149.382074151107, 5193.740312984336, 5270.762815673284, 5307.2835167252315, 5369.677819330833, 5375.973120134394, 5377.677339359631, 5430.945690543103, 5437.755301011464, 5190.039842629126, 5255.710935898524, 5257.605679574047, 5296.9735151324385, 5348.010618035656, 5210.088234558937, 5229.189475631283, 5276.261323414725, 5302.6023048271145, 5331.70675612845, 5175.870603234912, 5211.400688920785, 5265.315508983846, 5283.260343551906, 5339.919901201485, 5704.743286552115, 5879.7648094076185, 5910.67491287979, 5931.436513531207, 5955.672438015908, 6194.38056194377, 6201.410865967771, 6213.751449941997, 6226.657533835637, 6273.0, 6260.87478250437, 6275.497960163176, 6276.435120839146, 6303.338149494283, 6315.494760419156, 5890.116482527612, 5899.410058994066, 5924.7333869975955, 5927.673977931212, 5935.999999999957, 6208.72060757267, 6212.689365531795, 6222.28443728977, 6243.719032643542, 6249.187605611241, 6276.0, 6277.340879207709, 6284.277308109626, 6290.779822706183, 6295.811125666238, 5505.421930697219, 5959.016762234182, 6284.214473190851, 6312.495000399957, 6314.747410103636, 5485.957668043059, 5973.223480947449, 6220.875582488325, 6275.937240627627, 6288.748450062038, 6309.842253943688, 6323.873522529524, 6341.302456729756, 6341.841453963595, 6346.873062538723, 5009.524095210949, 5045.131209277277, 5046.369203849519, 5059.924101138486, 5094.465081166498, 4485.798139083749, 4486.327050942319, 4545.954540454553, 4583.54164583539, 4615.838445654453, 5838.7080645967535, 5866.70666466675, 5880.382559831241, 5888.676122813286, 5902.822915312548, 6198.907016394758, 6303.2751233607805, 6309.810705678837, 6310.968445157745, 6313.684315784192, 5847.210626565445, 5856.12158176277, 5906.675132867734, 5921.970390148022, 5969.283685957626, 5493.368262649767, 5498.752556134984, 5505.229267902497, 5512.035393806068, 5537.916931246034, 5462.344518657707, 6189.50483961282, 6245.875082498415, 6263.154474145932, 6389.48884089281, 6264.2796078451565, 6267.0, 6280.591761535486, 6293.087502312231, 6296.716647750954, 6352.777652782131, 6365.4589359903075, 6367.299597044414, 6370.872582548416, 6393.7122829471855, 6114.084479019511, 6137.070562331885, 6157.938420615916, 6237.251529816451, 6339.778107766206, 6284.842878928063, 6287.559870808999, 6290.119383286252, 6296.401841825019, 6300.558960872695, 6026.427489388501, 6194.473469755121, 6199.721012554536, 6200.162977997912, 6205.0, 4943.2585112233455, 6086.300075491198, 6106.06632622643, 6113.755449782137, 6189.195404597373, 5967.582269241111, 6032.487238584594, 6034.758609655564, 6069.9089513656445, 6090.878182436415, 6046.758129674764, 6150.10823430609, 6162.075688646739, 6174.228221472316, 6178.351273116438, 5980.760769569169, 6073.149759033827, 6099.085137229274, 6101.237345331833, 6102.0], "value": 5748.380188222002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.585005195428, 502.9270755740418, 520.0898427751437, 534.3587694766281, 557.3673880146033, 30093.0, 42228.0, 43520.78239608801, 43639.78180109095, 46233.53766462334, 44714.77642611782, 44924.77537612316, 45041.0, 45106.872328191814, 45233.09533809322, 8810.030896601369, 9707.22342212623, 9909.306348555603, 9912.702618921443, 9915.652952146676, 8755.212030917217, 8994.955025224865, 9005.099490051009, 9006.549672516381, 10383.0, 11792.705182370424, 12122.757544849097, 12128.787121287845, 12157.452914618863, 12180.756384872342, 11988.980936620397, 12050.517979280818, 12052.698682532875, 12067.215630984047, 12067.456964436622, 8734.082921293237, 10519.158467322595, 11837.408129593487, 11840.230385024946, 11886.93017628409, 42356.0, 42575.7227283182, 42684.573154268684, 42814.57185428137, 42818.14363712708, 3410.8973849455665, 3557.3063252665743, 3571.982140089283, 3605.513255710498, 3710.8144592770254, 25555.488890222092, 25935.351616209744, 30995.380092398027, 32475.35049299001, 33046.3390732184, 3242.951355729666, 3422.931541369159, 3423.828808559587, 3445.500402441632, 3447.4828775683595, 536824.315878422, 540540.0, 541468.0, 542449.0, 551833.999999996, 61326.386736132066, 62304.68847655733, 62468.68765656143, 62512.687436563436, 62559.0, 65402.0, 65445.0, 65520.67239663771, 65564.67217663881, 65600.01599976004, 16754.827162098536, 17011.0, 17014.149292535323, 17045.40341088081, 17049.0, 13177.143485673592, 13264.933675331562, 13274.070815043047, 13288.136271142539, 13309.0, 14503.057301275383, 16345.754813677566, 16399.0, 16436.6712665746, 16450.0, 7067.22260551339, 7107.431405487549, 7123.074000380021, 7188.748393806191, 7200.423966082701, 847.8384613079996, 890.9064548222473, 969.4328817641617, 1156.5836298932377, 1184.4196343791652, 24927.750722492907, 29858.656360463832, 30647.38705225883, 31050.68949310478, 31554.684453155634, 977.1108291454884, 1065.3965781498794, 1105.2042529378834, 1129.2151954391784, 1201.1411840533885, 15314.157721325211, 16000.279987400594, 16025.439109631106, 16075.678486430206, 16205.67588648244, 381215.0, 384149.0, 386763.0, 387239.0, 388986.0, 53044.73477632587, 53446.0, 61155.38844611586, 61436.38563614396, 61901.0, 1293.4179619171223, 1429.7783843504274, 1449.6013596260902, 1467.2810322941682, 1478.3716920309041, 25494.74505254924, 33255.334893301515, 33302.333953321286, 33368.1657958553, 33399.16502087467, 56989.43010570007, 57617.71191144017, 57814.42185578259, 57817.710911446855, 57820.0, 560716.0, 619361.0, 619816.0, 620415.0, 620831.0, 24917.0, 26196.345091372867, 26717.06490272831, 27235.910563577236, 27307.180784576496, 48699.269510958075, 49850.501494984586, 50018.99962000812, 50217.24239651595, 50905.74547127241, 40373.394399084624, 41698.0, 41874.0, 42703.0, 42888.78555607202, 41184.79407602943, 41301.96745081397, 41382.1723565533, 41677.0, 42698.0, 39810.0, 40353.0, 40539.79730101331, 40693.79653101716, 40907.1818563633, 34752.131196719274, 35502.8224858874, 36326.27347453089, 36447.0, 36796.81601591975, 25747.742522574536, 26041.479170416864, 26051.478970420863, 26130.477390452466, 27060.72939270582], "value": 20587.006738786986, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.78852160008, 388.73371740357857, 396.67472672408627, 399.6503059822657, 418.8513077857361, 11746.825317468249, 15719.371225150995, 20810.791892081073, 21132.049057792377, 21200.681989770128, 20800.959952002417, 21460.819654918974, 21744.238951636697, 21803.890980545115, 21816.781832181674, 5084.262781896623, 5726.656400615976, 5915.378885217055, 5925.88148237035, 5988.461038506533, 5844.970775146118, 5929.822105336825, 5964.0, 5966.791162309299, 5966.79116230932, 4999.600031997432, 5581.469760372758, 5819.650820950736, 5830.7667693292215, 5838.153467747175, 5655.26481557399, 5779.797707080253, 5786.971065144689, 5817.941820581804, 5823.359430462646, 4995.925061124086, 5022.296878437021, 5067.366579177603, 5083.542481176712, 5085.313482679828, 25894.223173304832, 26055.478890422273, 26115.955361785505, 26636.733632663618, 26670.866645666647, 2188.365374041526, 2271.5229801741652, 2299.241250387368, 2309.145616122029, 3014.532747424131, 14695.33870975798, 15776.368945242177, 15955.361785528565, 16347.673046539121, 16420.42528511508, 1787.8122797106378, 1853.8794978326366, 1862.0689655172414, 1875.812418758127, 1919.433767038727, 64745.67627161881, 74625.0105648333, 81938.59030704868, 94550.0, 113581.0, 9339.252859771203, 9885.15976142036, 10022.198224142052, 10153.0, 10735.355878647306, 12392.56626018085, 12457.75084498305, 13024.47902083906, 13568.457261709422, 13588.660283492794, 8657.350698697623, 8705.347098967603, 8770.736877893672, 8812.735617931472, 8851.911480885237, 7010.298970102949, 8762.430442021248, 8773.912260877438, 8869.645214191489, 8914.55427228636, 4521.412216411845, 4596.655250856199, 4621.514740952151, 4655.11552804966, 4657.6273898088075, 1864.2915692036938, 1895.8388536974512, 1922.692369220946, 1924.6054558815408, 1928.7203355513373, 895.359817730326, 899.4603238057244, 918.7473444802732, 934.990650093504, 976.6044751875502, 19857.4114070874, 20270.29053983133, 20541.0, 21613.34410758289, 21888.697303645888, 908.3006085314271, 949.4493193947632, 964.262339310428, 1006.9093781559695, 1007.1338648762058, 10811.427550934422, 11178.832317515244, 11193.94403027996, 11215.887841121648, 11280.2667826591, 613881.0, 615659.0, 617693.9115304395, 620605.0, 628190.0, 135113.0, 138100.30949845185, 144363.0, 149632.50367496186, 153061.0, 951.296040929707, 993.0764389118045, 1008.0524307151401, 1008.1380419741016, 1008.2186305613209, 18816.811831882053, 19095.331663391713, 19210.615787683888, 19251.614967700287, 19262.614747704687, 53346.0, 54718.726406367714, 56562.71718641545, 57772.71113644405, 58614.70692646509, 64526.677366612865, 82632.0, 82709.17290827015, 83144.16855831606, 84196.0, 7879.057269998479, 8057.879131813144, 8178.7955301117945, 8363.540005299767, 8384.371172162235, 10894.782104358026, 12847.0, 13138.343082846011, 13187.670308241986, 13213.405396756976, 10337.121344685786, 11194.370106056165, 11274.7745045097, 11338.943305283421, 11387.829182562102, 8852.89338832646, 10933.56265749361, 11036.558537658724, 11066.612668556561, 11269.211155219384, 11363.715907102058, 11467.0, 11533.135014874086, 11627.069834413058, 11668.008219301455, 6205.348438413902, 8049.959750201211, 8111.797205069921, 8313.875291870505, 8346.707865224687, 9175.357724959189, 11517.308961462339, 11692.590759323723, 11716.70708232301, 11898.524059037542], "value": 9597.215243247469, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.3760239091214, 1531.502261764926, 1563.6083885342048, 1757.6221112460819, 1921.7405650237213, 6814.727410903564, 8668.34987375947, 8923.509206993613, 8945.0, 9088.0, 7488.812779680511, 8718.825623487526, 8831.558422078886, 8919.598618062186, 8926.330525210618, 2104.2424727098232, 2194.6049711052005, 2377.8335516513853, 2409.409694624819, 2412.8311018228733, 2168.056895250571, 2310.5609934112463, 2368.834181607288, 2372.039324073753, 2372.79831214347, 2207.86752794832, 2308.284431826139, 2350.2596682045187, 2352.7882490575844, 2357.1396440299254, 2107.1782005018053, 2291.851029683082, 2336.5910965581043, 2354.682117914094, 2377.7741114594087, 2406.061635961976, 2434.6348047792794, 2439.256026911791, 2439.2804122783823, 2442.05980697431, 8984.32617553686, 9034.051424600388, 9036.322275829274, 9052.411593246483, 9053.547322633842, 5262.684238945675, 5437.700926449043, 5439.3200849893765, 5448.945510544883, 5449.3188351456065, 3418.418868792311, 3480.269143479872, 3520.8767693130617, 3538.663826936437, 3742.7567208131386, 1089.967300980972, 1101.3281898042187, 1108.157800071943, 1111.7887601355717, 1119.9048080913133, 11969.521219151224, 12011.39943002855, 12080.275183489019, 12131.818022729665, 12146.089043321697, 4666.766661666903, 4788.832390866303, 4803.489121276673, 4889.682170658896, 4967.205247160437, 8499.36254780894, 10204.4387558685, 10224.182065434896, 10227.7443063924, 10229.590816367261, 5458.399576046631, 5461.972690136524, 5472.2338872557875, 5473.808416705396, 5474.835754927359, 4415.558444155623, 4582.679212455096, 4800.279958006327, 4949.529794669501, 4986.7257300848805, 3283.6223834259367, 4031.1534577738416, 4092.4475195848777, 4133.028738246569, 4133.937990930139, 1289.6517940156293, 1291.728736965248, 1292.3538230884558, 1307.0523870194033, 1311.54096066376, 664.3754870421789, 820.3396266005923, 879.6349514951352, 890.1009979920198, 972.557486343712, 6153.661548614869, 6262.0, 6274.1843560337775, 6300.905486417708, 6364.172657554488, 867.8524650809378, 953.726774755695, 958.1328897347911, 1001.1440218613127, 1006.2754816532085, 4041.151358214749, 4157.251694694924, 4197.664186865043, 4211.305134652809, 4271.700980931305, 10725.731856703645, 11102.555897764161, 11201.327920324806, 11236.55053797839, 11273.887261127447, 11183.273087249303, 11186.272892261977, 11208.439578021067, 11210.607628732956, 11217.0, 7929.167437418988, 8307.626156822958, 8311.958440207882, 8319.251267385964, 8486.024107227624, 6128.050152226412, 6163.630182189083, 6206.386339551659, 6220.315765265907, 6473.611583304828, 9761.267904907303, 10212.336198147097, 10412.062914337746, 10430.582776688847, 10441.373517588969, 10303.072723454925, 10503.527341269813, 10528.947355263175, 10538.262321637412, 10572.84140737905, 7651.464397492122, 7729.806754831175, 7764.107127680389, 7808.804779880548, 7858.842823143619, 6621.6689165540565, 8477.533735644598, 8555.358348123791, 8564.828703426021, 8569.357298202784, 6268.279147897868, 7556.848863022598, 7638.236176382317, 7715.691372345268, 7836.568988705448, 7526.887096693664, 7677.577733224726, 7701.075870895528, 7754.883676744967, 7796.454248202572, 6016.608920420159, 7190.777567813589, 7294.671739771617, 7295.781126566211, 7303.342699156889, 4450.0, 4875.146849301429, 5075.3148324975655, 5257.710825904612, 5266.236395722675, 5210.6613070150315, 5229.47705229474, 5322.973385133049, 5351.732413379394, 5388.838334849804], "value": 4661.789491540231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [312.33472703142303, 313.80230454813466, 320.39925140361817, 324.0198399840481, 327.108628986013, 5354.30552918486, 5563.0, 5594.440555944404, 5624.465675760806, 5636.7745290188395, 4667.556582124693, 5094.006668699605, 5114.43741188469, 5584.692841893694, 5606.411326810678, 3918.686505079601, 3954.5056867891512, 3992.6805855531634, 4158.958410415888, 4213.346931225649, 3444.207832198596, 3804.923901521982, 3809.3333666608373, 4072.3891416287497, 4191.895202619929, 3723.90690232745, 3881.4760007399063, 4119.588041195886, 4167.916641667165, 4168.874933751992, 2966.7774916881103, 3934.586868378822, 4119.567445418218, 4133.173365326947, 4179.2686279901045, 3428.365752335826, 3613.8915832524804, 3615.4215325547784, 3615.891523254307, 3635.709143268532, 4255.574382581839, 5277.894442111136, 5304.496072873071, 5361.329833770778, 5418.729063546846, 3714.888553343404, 4541.250693635546, 4777.331173635694, 4780.760961951889, 4784.937639910425, 4698.365720627706, 5277.102892508245, 5550.222968784374, 5666.943330566683, 5765.509931655814, 3747.3442147624055, 4014.3577027675433, 4025.2754504189234, 4054.1283624020975, 4065.4308396824467, 4723.394046024368, 5355.491228333302, 5596.4403559644115, 5883.0, 5906.9704651476895, 3263.8368081595827, 4040.6363427291685, 4073.714839961174, 4116.485439320085, 4122.40225167349, 3842.481265029185, 4119.0937993641355, 4138.772367519815, 4141.730787498803, 4175.457190565207, 3987.980060099681, 4238.915221695611, 4785.0, 4795.992841503324, 4817.421909370828, 4717.504662010508, 5521.503064724194, 5736.799212027559, 5740.598158128974, 5758.971205143947, 1317.767887025634, 1390.3604342002793, 1423.5871597236892, 1427.9214643194723, 1431.398812498753, 733.1495465260273, 874.213208112691, 883.4919921045424, 893.093510087262, 898.7842917699705, 4337.0, 5076.238564215323, 5281.947180528223, 5317.229001794718, 5528.253685752372, 5720.799772007959, 5901.380355062656, 5923.259592550931, 5974.283086029617, 6067.33148384189, 4103.7742924138865, 4559.088182363541, 5180.067587834151, 5320.707361095177, 5572.944270557324, 2582.070113058424, 2997.1757766614355, 3120.458279852384, 3123.593932788723, 3139.230888432303, 4906.607471402351, 5088.872778180576, 6152.323244443108, 6178.104174894615, 6183.659898705614, 5682.948654498931, 6088.939110608926, 6112.786052488231, 6145.66198859067, 6174.024312220046, 5323.334583177103, 5949.732262048132, 6130.804493123887, 6142.877142457126, 6165.907511387422, 5138.588912887035, 5795.478406943395, 5876.912771137353, 6001.039833626599, 6026.337102918587, 4837.097741355159, 4953.1579631463455, 5857.163557869602, 5884.499817515559, 5889.352171261244, 5072.30811499369, 5525.535733030831, 5992.340842507408, 6177.6911154441195, 6190.597611155261, 3806.3338915690197, 3936.1106668799707, 3979.582143874967, 4001.7598944063448, 4011.7592944423427, 5550.4449555044175, 5709.885802283848, 5938.0, 5942.376050514807, 5953.880922381441, 5579.804706835242, 5694.0, 5707.687231936595, 5764.538836892954, 5778.422157784356, 4888.535589119028, 5143.045642655767, 5694.700501121627, 5738.876615652069, 5873.177755114202, 4630.166570017429, 5696.743646535833, 5706.885862282648, 5772.884542309214, 5774.56690748204, 5827.883442331215, 5835.44563266489, 5851.94148058531, 5860.238169037998, 5916.994111001054, 5570.777168913198, 5665.178549110438, 5673.489385955284, 5763.279590051244, 5797.188393624811], "value": 4181.125356641569, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.5133388964117, 779.3180966654174, 784.3999340504512, 816.2735165702529, 824.6701319472212, 14996.250187490623, 15577.688446231068, 16266.75599866, 16279.267432965515, 16287.918560407212, 14532.564023079298, 14772.261386930664, 14796.778048329285, 14806.925965370157, 14846.1834599097, 709.4041005555332, 764.7973287078928, 904.5386852705118, 909.8089401225717, 941.5951141009364, 744.94040476762, 927.2350310993423, 931.5295775633296, 933.9066093390641, 934.6868798952326, 988.5403287471361, 988.5946761827652, 990.3216296836654, 992.4045572656385, 992.9851052234222, 773.4817672159638, 869.3132425383939, 981.6024510073431, 988.002117860962, 995.6166875752888, 742.2985278911431, 742.840289337795, 743.9888401673979, 744.8845428958521, 745.437194917839, 14819.851801481955, 15203.315850786741, 15210.08739475624, 15219.0, 15226.086434813946, 13487.595372138852, 13695.520656777064, 13751.381187846471, 13753.862461375358, 13970.650733731636, 12976.286304253263, 13043.413046412934, 13131.0, 13267.535636252782, 13575.253361065137, 4585.793639286207, 4655.092257009885, 4660.836870709542, 4742.620590352763, 4826.686265392738, 103615.96384036138, 105511.0, 109844.0, 110183.0, 111744.0, 11192.38441885704, 11195.740663972936, 11263.380514071805, 11464.828027579593, 11683.415829208505, 21765.45586360322, 21838.89080554587, 21871.781282187294, 22173.445663858532, 22667.773322266898, 8057.919420805834, 8060.556669383123, 8090.595470226465, 8100.83798324042, 8276.420650554403, 4484.850884399557, 4494.033782736662, 4617.607503362185, 4643.3963584733765, 4738.3129446230105, 3566.7503274771034, 3688.096416377951, 3689.2437050405138, 3691.667749902522, 3699.2786406650443, 493.73091665042637, 674.7941877727341, 685.8833998220315, 688.18793823288, 689.6999805084804, 590.4774274766862, 682.9897551536731, 695.3220609905403, 699.7166147710185, 724.5616402076773, 9047.457152570867, 9266.166045055978, 9555.952220238854, 9641.866418315545, 9821.508924553744, 637.8564822914807, 651.7165033210568, 668.7124536449277, 669.4242951062083, 680.0683064202075, 4090.8977275567754, 4645.883852903705, 4685.81256749733, 4730.7448502363595, 4783.234682450791, 104876.0, 130543.34728326298, 155305.0, 163060.18469907812, 168964.84657467122, 130499.0, 130629.34685326513, 133701.33149334192, 141658.0, 145524.0, 102707.0, 119200.2519836208, 121317.3934130306, 123514.0, 128589.0, 9079.364444488823, 9150.313726470407, 9174.816503669756, 9196.172344488761, 9321.766955825888, 67817.66091169513, 69796.0, 69901.65049174722, 70240.64879675569, 70502.0, 100387.0, 102366.97633023873, 102787.4860625722, 102867.45698814673, 103985.0, 12217.633470995885, 12314.13801033919, 12339.259644421005, 12427.93786031064, 12989.935050324688, 9933.900660993297, 12216.816747748613, 13259.602211933658, 13876.947071644223, 13924.860751392762, 9559.522023898917, 11289.98390144891, 13550.525731599346, 13717.519886804314, 14240.430382784987, 13959.371828267549, 14275.928620356832, 14313.069650472686, 14642.85357146415, 14664.926675366554, 13823.654408639864, 13890.930545347208, 14160.504382346568, 14392.352344144329, 14403.567892963229, 11028.889711102785, 11278.943605281922, 11326.943365283121, 11359.48882300282, 11392.48733806964, 10935.641535647634, 11444.0, 11481.712957176138, 11572.826407603725, 11650.825237621273], "value": 8076.922433995616, "unit": "score"}], "name": "dromaeo_css", "value": 7505.9131512993745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 113.0, 114.0, 112.0, 113.0, 112.0, 112.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 113.0, 113.0, 200.0, 139.0, 118.0, 128.0, 108.0, 142.0, 106.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 186.0, 185.0, 186.0, 218.0, 184.0, 180.0, 183.0, 182.0], "value": 187.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 56.0, 106.0, 56.0, 56.0, 66.0, 59.0, 94.0, 55.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 90.0, 71.0, 73.0, 80.0, 130.0, 100.0, 76.0, 99.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 100.0, 111.0, 129.0, 122.0, 84.0, 89.0, 85.0, 90.0, 86.0], "value": 98.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 100.0, 97.0, 92.0, 93.0, 93.0, 92.0], "value": 93.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 85.0, 84.0, 83.0, 84.0, 86.0, 84.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 50.0, 53.0, 53.0, 54.0, 53.0, 51.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 76.0, 78.0, 71.0, 72.0, 68.0, 70.0, 71.0, 71.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 81.0, 85.0, 83.0, 84.0, 81.0, 86.0, 93.0, 103.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 135.0, 161.0, 153.0, 142.0, 131.0, 138.0, 221.0, 137.0], "value": 149.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 157.0, 162.0, 168.0, 221.0, 203.0, 160.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 66.0, 67.0, 66.0, 66.0, 65.0, 64.0, 65.0, 65.0], "value": 66.0, "unit": "score"}], "name": "kraken", "value": 1462.7000000000003, "alertThreshold": 2.0}]} 10:11:40 INFO - Return code: 0 10:11:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:11:40 INFO - # TBPL SUCCESS # 10:11:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:11:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:11:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:11:40 INFO - 2016-07-04 10:11:40.596 screenresolution[1996:14355] starting screenresolution argv=screenresolution get 10:11:40 INFO - 2016-07-04 10:11:40.598 screenresolution[1996:14355] Display 0: 1600x1200x32@60 10:11:40 INFO - 2016-07-04 10:11:40.604 screenresolution[1997:14358] starting screenresolution argv=screenresolution list 10:11:40 INFO - Available Modes on Display 0 10:11:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:11:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:11:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:11:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:11:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:11:40 INFO - Intel Iris: 10:11:40 INFO - Chipset Model: Intel Iris 10:11:40 INFO - Type: GPU 10:11:40 INFO - Bus: Built-In 10:11:40 INFO - VRAM (Dynamic, Max): 1536 MB 10:11:40 INFO - Vendor: Intel (0x8086) 10:11:40 INFO - Device ID: 0x0a2e 10:11:40 INFO - Revision ID: 0x0009 10:11:40 INFO - Displays: 10:11:40 INFO - Display: 10:11:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:11:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:11:40 INFO - Display Serial Number: 1600x1200 60 10:11:40 INFO - Main Display: Yes 10:11:40 INFO - Mirror: Off 10:11:40 INFO - Online: Yes 10:11:40 INFO - Rotation: Supported 10:11:40 INFO - Return code: 0 10:11:40 INFO - Running post-action listener: _resource_record_post_action 10:11:40 INFO - ##### 10:11:40 INFO - ##### Finished run-tests step (success) 10:11:40 INFO - ##### 10:11:40 INFO - Running post-run listener: _resource_record_post_run 10:11:40 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 282624; Write bytes: 705570304; Read time: 3; Write time: 1936 10:11:40 INFO - TinderboxPrint: CPU usage
53.6% 10:11:40 INFO - TinderboxPrint: I/O read bytes / time
282,624 / 3 10:11:40 INFO - TinderboxPrint: I/O write bytes / time
705,570,304 / 1,936 10:11:40 INFO - TinderboxPrint: CPU idle
2,249.8 (46.4%) 10:11:40 INFO - TinderboxPrint: CPU system
969.6 (20.0%) 10:11:40 INFO - TinderboxPrint: CPU user
1,626.2 (33.6%) 10:11:40 INFO - TinderboxPrint: Swap in / out
406,601,728 / 0 10:11:40 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 392040960; Write bytes: 386827776; Read time: 29683; Write time: 779 10:11:40 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 282624; Write bytes: 295530496; Read time: 3; Write time: 1100 10:11:41 INFO - Running post-run listener: _upload_blobber_files 10:11:41 INFO - Blob upload gear active. 10:11:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:11:41 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 10:11:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:11:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:11:41 INFO - (blobuploader) - INFO - Open directory for files ... 10:11:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:11:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:11:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:42 INFO - (blobuploader) - INFO - Done attempting. 10:11:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:11:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:11:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:43 INFO - (blobuploader) - INFO - Done attempting. 10:11:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:11:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:11:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:11:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:11:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:11:45 INFO - (blobuploader) - INFO - Done attempting. 10:11:45 INFO - (blobuploader) - INFO - Iteration through files over. 10:11:45 INFO - Return code: 0 10:11:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:11:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:11:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46b5ac99df821d9ec9f560c265201ed3dfdfa394a1c50308187c70c6593e01eee153acce8fafe83ff191ff1b9dd5fb62aafda35585e315a10f8699cf901e3683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d521f221011f0804c57703b81cb734b28093da59dabbc5de05cdfdbe8da710970b8fe0bdb2bdd0a718782d67b286cf0365edad2917e0099239a517c8db584f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52dced57cbd2d21149a68c99d2b08fb63cded00ab5671e3d41e21c4185ba3259bff080579d0d5a3899ee1980374813da1ba4b8fdf0d0af9a95487f3f9f8b33b2"} 10:11:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:11:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:11:45 INFO - Contents: 10:11:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46b5ac99df821d9ec9f560c265201ed3dfdfa394a1c50308187c70c6593e01eee153acce8fafe83ff191ff1b9dd5fb62aafda35585e315a10f8699cf901e3683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d521f221011f0804c57703b81cb734b28093da59dabbc5de05cdfdbe8da710970b8fe0bdb2bdd0a718782d67b286cf0365edad2917e0099239a517c8db584f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52dced57cbd2d21149a68c99d2b08fb63cded00ab5671e3d41e21c4185ba3259bff080579d0d5a3899ee1980374813da1ba4b8fdf0d0af9a95487f3f9f8b33b2"} 10:11:45 INFO - Running post-run listener: copy_logs_to_upload_dir 10:11:45 INFO - Copying logs to upload dir... 10:11:45 INFO - mkdir: /builds/slave/test/build/upload/logs 10:11:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.777862 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-07-04 10:11:45.923475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 10:11:45.927096) ========= 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.3y653nJAof/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.nXPKh6aeX9/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46b5ac99df821d9ec9f560c265201ed3dfdfa394a1c50308187c70c6593e01eee153acce8fafe83ff191ff1b9dd5fb62aafda35585e315a10f8699cf901e3683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d521f221011f0804c57703b81cb734b28093da59dabbc5de05cdfdbe8da710970b8fe0bdb2bdd0a718782d67b286cf0365edad2917e0099239a517c8db584f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52dced57cbd2d21149a68c99d2b08fb63cded00ab5671e3d41e21c4185ba3259bff080579d0d5a3899ee1980374813da1ba4b8fdf0d0af9a95487f3f9f8b33b2"} build_url:https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011287 build_url: 'https://queue.taskcluster.net/v1/task/dy2SHZCORq6nXn1dRfij0Q/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/46b5ac99df821d9ec9f560c265201ed3dfdfa394a1c50308187c70c6593e01eee153acce8fafe83ff191ff1b9dd5fb62aafda35585e315a10f8699cf901e3683", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5d521f221011f0804c57703b81cb734b28093da59dabbc5de05cdfdbe8da710970b8fe0bdb2bdd0a718782d67b286cf0365edad2917e0099239a517c8db584f8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52dced57cbd2d21149a68c99d2b08fb63cded00ab5671e3d41e21c4185ba3259bff080579d0d5a3899ee1980374813da1ba4b8fdf0d0af9a95487f3f9f8b33b2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 10:11:45.959180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 10:11:45.959538) ========= 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.3y653nJAof/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.nXPKh6aeX9/Listeners TMPDIR=/var/folders/jj/387lhx_94cxf0qmq_s0q96_000000w/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.005193 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 10:11:46.009023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 10:11:46.009354) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 10:11:46.009734) ========= ========= Total master_lag: 0.22 =========