builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0254 starttime: 1468857874.42 results: success (0) buildid: 20160718065251 builduid: f70a420da4a842ca8ceee41c2e936511 revision: 1249782e3771430f4328851c1e8d198c204a4cd0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.415958) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.416364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.416677) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.442923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.443199) ========= 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.GthjlbxKje/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.kCiU9WwSVo/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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-18 09:04:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 150M=0s 2016-07-18 09:04:34 (150 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121944 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.586866) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.587168) ========= 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.GthjlbxKje/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.kCiU9WwSVo/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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.029931 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:34.637400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 09:04:34.637789) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1249782e3771430f4328851c1e8d198c204a4cd0 --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 1249782e3771430f4328851c1e8d198c204a4cd0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GthjlbxKje/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.kCiU9WwSVo/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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-18 09:04:34,723 truncating revision to first 12 chars 2016-07-18 09:04:34,723 Setting DEBUG logging. 2016-07-18 09:04:34,723 attempt 1/10 2016-07-18 09:04:34,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1249782e3771?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 09:04:35,766 unpacking tar archive at: fx-team-1249782e3771/testing/mozharness/ program finished with exit code 0 elapsedTime=1.334794 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 09:04:35.994554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:35.994914) ========= script_repo_revision: 1249782e3771430f4328851c1e8d198c204a4cd0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:35.995335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:35.995612) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 09:04:36.013785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-07-18 09:04:36.014207) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GthjlbxKje/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.kCiU9WwSVo/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:04:36 INFO - MultiFileLogger online at 20160718 09:04:36 in /builds/slave/test 09:04:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:04:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:36 INFO - {'append_to_log': False, 09:04:36 INFO - 'base_work_dir': '/builds/slave/test', 09:04:36 INFO - 'blob_upload_branch': 'Fx-Team', 09:04:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:36 INFO - 'branch': 'Fx-Team', 09:04:36 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:36 INFO - 'config_files': ('talos/mac_config.py',), 09:04:36 INFO - 'default_actions': ('clobber', 09:04:36 INFO - 'read-buildbot-config', 09:04:36 INFO - 'download-and-extract', 09:04:36 INFO - 'populate-webroot', 09:04:36 INFO - 'create-virtualenv', 09:04:36 INFO - 'install', 09:04:36 INFO - 'run-tests'), 09:04:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:36 INFO - 'download_minidump_stackwalk': True, 09:04:36 INFO - 'download_symbols': 'ondemand', 09:04:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:36 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:36 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:36 INFO - 'installer_path': 'installer.exe', 09:04:36 INFO - 'log_level': 'info', 09:04:36 INFO - 'log_name': 'talos', 09:04:36 INFO - 'log_to_console': True, 09:04:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:04:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:04:36 INFO - 'opt_config_files': (), 09:04:36 INFO - 'pip_index': False, 09:04:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:04:36 INFO - 'cmd': ('bash', 09:04:36 INFO - '-c', 09:04:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:04:36 INFO - 'enabled': True, 09:04:36 INFO - 'halt_on_failure': False, 09:04:36 INFO - 'name': 'check_screen_resolution'},), 09:04:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:04:36 INFO - 'cmd': ('bash', 09:04:36 INFO - '-c', 09:04:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:04:36 INFO - 'enabled': True, 09:04:36 INFO - 'halt_on_failure': False, 09:04:36 INFO - 'name': 'check_screen_resolution'},), 09:04:36 INFO - 'run_cmd_checks_enabled': True, 09:04:36 INFO - 'sps_profile': False, 09:04:36 INFO - 'sps_profile_interval': 0, 09:04:36 INFO - 'suite': 'dromaeojs-e10s', 09:04:36 INFO - 'system_bits': '32', 09:04:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:36 INFO - 'title': 't-yosemite-r7-0254', 09:04:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:36 INFO - 'use_talos_json': True, 09:04:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:36 INFO - 'work_dir': 'build'} 09:04:36 INFO - ##### 09:04:36 INFO - ##### Running clobber step. 09:04:36 INFO - ##### 09:04:36 INFO - Running pre-action listener: _resource_record_pre_action 09:04:36 INFO - Running main action method: clobber 09:04:36 INFO - rmtree: /builds/slave/test/build 09:04:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:37 INFO - Running post-action listener: _resource_record_post_action 09:04:37 INFO - ##### 09:04:37 INFO - ##### Finished clobber step (success) 09:04:37 INFO - ##### 09:04:37 INFO - ##### 09:04:37 INFO - ##### Running read-buildbot-config step. 09:04:37 INFO - ##### 09:04:37 INFO - Running pre-action listener: _resource_record_pre_action 09:04:37 INFO - Running main action method: read_buildbot_config 09:04:37 INFO - Using buildbot properties: 09:04:37 INFO - { 09:04:37 INFO - "project": "", 09:04:37 INFO - "product": "firefox", 09:04:37 INFO - "script_repo_revision": "production", 09:04:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:04:37 INFO - "repository": "", 09:04:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:04:37 INFO - "buildid": "20160718065251", 09:04:37 INFO - "pgo_build": "False", 09:04:37 INFO - "basedir": "/builds/slave/test", 09:04:37 INFO - "buildnumber": 724, 09:04:37 INFO - "slavename": "t-yosemite-r7-0254", 09:04:37 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:04:37 INFO - "platform": "yosemite_r7", 09:04:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:04:37 INFO - "branch": "fx-team", 09:04:37 INFO - "repo_path": "integration/fx-team", 09:04:37 INFO - "revision": "1249782e3771430f4328851c1e8d198c204a4cd0", 09:04:37 INFO - "stage_platform": "macosx64", 09:04:37 INFO - "builduid": "f70a420da4a842ca8ceee41c2e936511", 09:04:37 INFO - "slavebuilddir": "test" 09:04:37 INFO - } 09:04:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 09:04:37 INFO - Running post-action listener: _resource_record_post_action 09:04:37 INFO - ##### 09:04:37 INFO - ##### Finished read-buildbot-config step (success) 09:04:37 INFO - ##### 09:04:37 INFO - ##### 09:04:37 INFO - ##### Running download-and-extract step. 09:04:37 INFO - ##### 09:04:37 INFO - Running pre-action listener: _resource_record_pre_action 09:04:37 INFO - Running main action method: download_and_extract 09:04:37 INFO - mkdir: /builds/slave/test/build/tests 09:04:37 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:04:37 INFO - https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:04:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:04:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:04:53 INFO - Downloaded 1199 bytes. 09:04:53 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:04:53 INFO - Using the following test package requirements: 09:04:53 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:04:53 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:04:53 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:04:53 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'jsshell-mac.zip'], 09:04:53 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:04:53 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:04:53 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:04:53 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:04:53 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:04:53 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:04:53 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:04:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:04: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:04:53 INFO - https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:04:59 INFO - Downloaded 18835925 bytes. 09:04:59 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:04:59 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:05:02 INFO - Return code: 0 09:05:02 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:05: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:05:02 INFO - https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:05:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:05:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:05:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:05:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:05:05 INFO - Downloaded 18835925 bytes. 09:05:05 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:05:05 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:05:09 INFO - Return code: 0 09:05: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:05:09 INFO - https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:05:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:05:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:05:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:05:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:05:10 INFO - Downloaded 14403317 bytes. 09:05:10 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:05:10 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:05:10 INFO - Return code: 0 09:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:10 INFO - https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:05:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:05:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:05:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:05:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/A0kSV0ekShiGxrq3BId_LQ/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:05:15 INFO - Downloaded 112759175 bytes. 09:05:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:05:15 INFO - mkdir: /builds/slave/test/properties 09:05:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:15 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:15 INFO - Contents: 09:05:15 INFO - build_url:https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:05:16 INFO - Running post-action listener: _resource_record_post_action 09:05:16 INFO - Running post-action listener: set_extra_try_arguments 09:05:16 INFO - ##### 09:05:16 INFO - ##### Finished download-and-extract step (success) 09:05:16 INFO - ##### 09:05:16 INFO - ##### 09:05:16 INFO - ##### Running populate-webroot step. 09:05:16 INFO - ##### 09:05:16 INFO - Running pre-action listener: _resource_record_pre_action 09:05:16 INFO - Running main action method: populate_webroot 09:05:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:16 INFO - '--tppagecycles', 09:05:16 INFO - '7'], 09:05:16 INFO - 'tests': ['tsvgm']}}, 09:05:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['damp', 'tps']}, 09:05:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'tests': ['damp', 'tps']}, 09:05:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['dromaeo_dom']}, 09:05:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['basic_compositor_video']}, 09:05:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['a11yr', 09:05:16 INFO - 'ts_paint', 09:05:16 INFO - 'tpaint', 09:05:16 INFO - 'sessionrestore', 09:05:16 INFO - 'sessionrestore_no_auto_restore', 09:05:16 INFO - 'tabpaint']}, 09:05:16 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:16 INFO - 'ts_paint', 09:05:16 INFO - 'tpaint', 09:05:16 INFO - 'sessionrestore', 09:05:16 INFO - 'sessionrestore_no_auto_restore', 09:05:16 INFO - 'tabpaint']}, 09:05:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:16 INFO - 'ts_paint', 09:05:16 INFO - 'tpaint', 09:05:16 INFO - 'sessionrestore', 09:05:16 INFO - 'sessionrestore_no_auto_restore', 09:05:16 INFO - 'tabpaint']}, 09:05:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:16 INFO - 'ts_paint', 09:05:16 INFO - 'tpaint', 09:05:16 INFO - 'sessionrestore', 09:05:16 INFO - 'sessionrestore_no_auto_restore', 09:05:16 INFO - 'tabpaint']}, 09:05:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['a11yr', 09:05:16 INFO - 'ts_paint', 09:05:16 INFO - 'tpaint', 09:05:16 INFO - 'sessionrestore', 09:05:16 INFO - 'sessionrestore_no_auto_restore', 09:05:16 INFO - 'tabpaint']}, 09:05:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['a11yr', 09:05:16 INFO - 'ts_paint', 09:05:16 INFO - 'tpaint', 09:05:16 INFO - 'sessionrestore', 09:05:16 INFO - 'sessionrestore_no_auto_restore', 09:05:16 INFO - 'tabpaint']}, 09:05:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['tsvgx', 09:05:16 INFO - 'tsvgr_opacity', 09:05:16 INFO - 'tart', 09:05:16 INFO - 'tscrollx', 09:05:16 INFO - 'cart']}, 09:05:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:16 INFO - 'tsvgr_opacity', 09:05:16 INFO - 'tart', 09:05:16 INFO - 'tscrollx', 09:05:16 INFO - 'cart']}, 09:05:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'talos_options': ['--disable-e10s'], 09:05:16 INFO - 'tests': ['tp5o']}, 09:05:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'tests': ['tp5o']}, 09:05:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'talos_options': ['--disable-e10s', 09:05:16 INFO - '--xperf_path', 09:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:16 INFO - 'tests': ['tp5n']}, 09:05:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:05:16 INFO - 'talos_options': ['--xperf_path', 09:05:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:16 INFO - 'tests': ['tp5n']}}, 09:05:16 INFO - 'talos.zip': {'path': '', 09:05:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:16 INFO - Running post-action listener: _resource_record_post_action 09:05:16 INFO - ##### 09:05:16 INFO - ##### Finished populate-webroot step (success) 09:05:16 INFO - ##### 09:05:16 INFO - ##### 09:05:16 INFO - ##### Running create-virtualenv step. 09:05:16 INFO - ##### 09:05:16 INFO - Running pre-action listener: _resource_record_pre_action 09:05:16 INFO - Running main action method: create_virtualenv 09:05:16 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:16 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:05:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:16 INFO - Using real prefix '/tools/python27' 09:05:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:17 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:20 INFO - Installing pip.................done. 09:05:20 INFO - Return code: 0 09:05:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:20 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:20 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:05:20 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:05:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:20 INFO - 'HOME': '/Users/cltbld', 09:05:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:20 INFO - 'LOGNAME': 'cltbld', 09:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:20 INFO - 'MOZ_NO_REMOTE': '1', 09:05:20 INFO - 'NO_EM_RESTART': '1', 09:05:20 INFO - 'PAGER': '/bin/cat', 09:05:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:20 INFO - 'PWD': '/builds/slave/test', 09:05:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:20 INFO - 'SHELL': '/bin/bash', 09:05:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:20 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:20 INFO - 'USER': 'cltbld', 09:05:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:20 INFO - 'XPC_FLAGS': '0x0', 09:05:20 INFO - 'XPC_SERVICE_NAME': '0', 09:05:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:20 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:05:20 INFO - Cleaning up... 09:05:20 INFO - Return code: 0 09:05:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:20 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:20 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:05:20 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:05:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:20 INFO - 'HOME': '/Users/cltbld', 09:05:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:20 INFO - 'LOGNAME': 'cltbld', 09:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:20 INFO - 'MOZ_NO_REMOTE': '1', 09:05:20 INFO - 'NO_EM_RESTART': '1', 09:05:20 INFO - 'PAGER': '/bin/cat', 09:05:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:20 INFO - 'PWD': '/builds/slave/test', 09:05:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:20 INFO - 'SHELL': '/bin/bash', 09:05:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:20 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:20 INFO - 'USER': 'cltbld', 09:05:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:20 INFO - 'XPC_FLAGS': '0x0', 09:05:20 INFO - 'XPC_SERVICE_NAME': '0', 09:05:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:20 INFO - Downloading/unpacking psutil>=3.1.1 09:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:20 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:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:24 INFO - Installing collected packages: psutil 09:05:24 INFO - Running setup.py install for psutil 09:05:24 INFO - building 'psutil._psutil_osx' extension 09:05:24 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:05:24 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:05:24 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:05:24 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:05:25 INFO - building 'psutil._psutil_posix' extension 09:05:25 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:05:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:05:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:05:25 INFO - ^ 09:05:25 INFO - 1 warning generated. 09:05:25 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:05:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:25 INFO - Successfully installed psutil 09:05:25 INFO - Cleaning up... 09:05:25 INFO - Return code: 0 09:05:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:05:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:05:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:25 INFO - 'HOME': '/Users/cltbld', 09:05:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:25 INFO - 'LOGNAME': 'cltbld', 09:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:25 INFO - 'MOZ_NO_REMOTE': '1', 09:05:25 INFO - 'NO_EM_RESTART': '1', 09:05:25 INFO - 'PAGER': '/bin/cat', 09:05:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:25 INFO - 'PWD': '/builds/slave/test', 09:05:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:25 INFO - 'SHELL': '/bin/bash', 09:05:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:25 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:25 INFO - 'USER': 'cltbld', 09:05:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:25 INFO - 'XPC_FLAGS': '0x0', 09:05:25 INFO - 'XPC_SERVICE_NAME': '0', 09:05:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05: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:05: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:05: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:05: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:05: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:05: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:05:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:28 INFO - Installing collected packages: mozsystemmonitor 09:05:28 INFO - Running setup.py install for mozsystemmonitor 09:05:28 INFO - Successfully installed mozsystemmonitor 09:05:28 INFO - Cleaning up... 09:05:28 INFO - Return code: 0 09:05:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05: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:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:28 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:28 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:05:28 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:05:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:28 INFO - 'HOME': '/Users/cltbld', 09:05:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:28 INFO - 'LOGNAME': 'cltbld', 09:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:28 INFO - 'MOZ_NO_REMOTE': '1', 09:05:28 INFO - 'NO_EM_RESTART': '1', 09:05:28 INFO - 'PAGER': '/bin/cat', 09:05:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:28 INFO - 'PWD': '/builds/slave/test', 09:05:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:28 INFO - 'SHELL': '/bin/bash', 09:05:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:28 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:28 INFO - 'USER': 'cltbld', 09:05:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:28 INFO - 'XPC_FLAGS': '0x0', 09:05:28 INFO - 'XPC_SERVICE_NAME': '0', 09:05:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:28 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:31 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:31 INFO - warning: no files found matching '*.txt' 09:05:31 INFO - no previously-included directories found matching 'build' 09:05:31 INFO - no previously-included directories found matching 'dist' 09:05:31 INFO - no previously-included directories found matching '.git*' 09:05:31 INFO - Installing collected packages: jsonschema, functools32 09:05:31 INFO - Running setup.py install for functools32 09:05:31 INFO - warning: no files found matching '*.txt' 09:05:31 INFO - no previously-included directories found matching 'build' 09:05:31 INFO - no previously-included directories found matching 'dist' 09:05:31 INFO - no previously-included directories found matching '.git*' 09:05:31 INFO - Successfully installed jsonschema functools32 09:05:31 INFO - Cleaning up... 09:05:31 INFO - Return code: 0 09:05:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:31 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:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:31 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:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:31 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:31 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:05:31 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:05:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:31 INFO - 'HOME': '/Users/cltbld', 09:05:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:31 INFO - 'LOGNAME': 'cltbld', 09:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:31 INFO - 'MOZ_NO_REMOTE': '1', 09:05:31 INFO - 'NO_EM_RESTART': '1', 09:05:31 INFO - 'PAGER': '/bin/cat', 09:05:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:31 INFO - 'PWD': '/builds/slave/test', 09:05:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:31 INFO - 'SHELL': '/bin/bash', 09:05:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:31 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:31 INFO - 'USER': 'cltbld', 09:05:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:31 INFO - 'XPC_FLAGS': '0x0', 09:05:31 INFO - 'XPC_SERVICE_NAME': '0', 09:05:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:32 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:05:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:35 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:05:35 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:05:35 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:05:35 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:05:35 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:05:35 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:05:35 INFO - Downloading docopt-0.6.1.tar.gz 09:05:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:35 INFO - Running setup.py install for blobuploader 09:05:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:35 INFO - Running setup.py install for requests 09:05:36 INFO - Running setup.py install for docopt 09:05:36 INFO - Successfully installed blobuploader requests docopt 09:05:36 INFO - Cleaning up... 09:05:36 INFO - Return code: 0 09:05:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:36 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:05:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:36 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:05:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:36 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:36 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:05:36 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:05:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:36 INFO - 'HOME': '/Users/cltbld', 09:05:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:36 INFO - 'LOGNAME': 'cltbld', 09:05:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:36 INFO - 'MOZ_NO_REMOTE': '1', 09:05:36 INFO - 'NO_EM_RESTART': '1', 09:05:36 INFO - 'PAGER': '/bin/cat', 09:05:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:36 INFO - 'PWD': '/builds/slave/test', 09:05:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:36 INFO - 'SHELL': '/bin/bash', 09:05:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:36 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:36 INFO - 'USER': 'cltbld', 09:05:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:36 INFO - 'XPC_FLAGS': '0x0', 09:05:36 INFO - 'XPC_SERVICE_NAME': '0', 09:05:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:36 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-v8EdP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-mOC8CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-20mwLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-09Qnh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-RzF3oF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-pqo_vy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-Y9dHkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-m2DjyT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-cxXs6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-vlTy7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:37 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-uhHIGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:38 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-vhqAk_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:38 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-_Jn0qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:38 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-9uyGqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:38 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-9rPOOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:38 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-jtMbEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:38 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-46jSfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:38 INFO - Running setup.py install for manifestparser 09:05:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:38 INFO - Running setup.py install for mozcrash 09:05:38 INFO - Running setup.py install for mozdebug 09:05:39 INFO - Running setup.py install for mozdevice 09:05:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Running setup.py install for mozfile 09:05:39 INFO - Running setup.py install for mozhttpd 09:05:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Running setup.py install for mozinfo 09:05:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Running setup.py install for mozInstall 09:05:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:39 INFO - Running setup.py install for mozleak 09:05:39 INFO - Running setup.py install for mozlog 09:05:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:40 INFO - Running setup.py install for moznetwork 09:05:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:40 INFO - Running setup.py install for mozprocess 09:05:40 INFO - Running setup.py install for mozprofile 09:05:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:40 INFO - Running setup.py install for mozrunner 09:05:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:40 INFO - Running setup.py install for mozscreenshot 09:05:40 INFO - Running setup.py install for moztest 09:05:41 INFO - Running setup.py install for mozversion 09:05:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:41 INFO - Cleaning up... 09:05:41 INFO - Return code: 0 09:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:41 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:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:41 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:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:41 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:41 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:05:41 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:05:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:41 INFO - 'HOME': '/Users/cltbld', 09:05:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:41 INFO - 'LOGNAME': 'cltbld', 09:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:41 INFO - 'MOZ_NO_REMOTE': '1', 09:05:41 INFO - 'NO_EM_RESTART': '1', 09:05:41 INFO - 'PAGER': '/bin/cat', 09:05:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:41 INFO - 'PWD': '/builds/slave/test', 09:05:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:41 INFO - 'SHELL': '/bin/bash', 09:05:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:41 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:41 INFO - 'USER': 'cltbld', 09:05:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:41 INFO - 'XPC_FLAGS': '0x0', 09:05:41 INFO - 'XPC_SERVICE_NAME': '0', 09:05:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:41 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-JH7sP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:41 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:05:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:41 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-6KIxOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-C73DcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-_jqafA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-jVmbYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-H_BN50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-PbKcu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-SnNt9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-bTfgyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-TFrLjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:42 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:05:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:42 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-VcBZ6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:43 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:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:43 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-AxIWrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:43 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-pdn9ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:43 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:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:43 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-cbOK7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:43 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-aDEVZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:43 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:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:43 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-ocNQbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:43 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:05:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:43 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-L4g0qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:43 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:05:46 INFO - Downloading blessings-1.6.tar.gz 09:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:46 INFO - Installing collected packages: blessings 09:05:46 INFO - Running setup.py install for blessings 09:05:46 INFO - Successfully installed blessings 09:05:46 INFO - Cleaning up... 09:05:46 INFO - Return code: 0 09:05:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:46 INFO - Reading from file tmpfile_stdout 09:05:46 INFO - Current package versions: 09:05:46 INFO - blessings == 1.6 09:05:46 INFO - blobuploader == 1.2.4 09:05:46 INFO - docopt == 0.6.1 09:05:46 INFO - functools32 == 3.2.3-2 09:05:46 INFO - jsonschema == 2.5.1 09:05:46 INFO - manifestparser == 1.1 09:05:46 INFO - mozInstall == 1.12 09:05:46 INFO - mozcrash == 0.17 09:05:46 INFO - mozdebug == 0.1 09:05:46 INFO - mozdevice == 0.48 09:05:46 INFO - mozfile == 1.2 09:05:46 INFO - mozhttpd == 0.7 09:05:46 INFO - mozinfo == 0.9 09:05:46 INFO - mozleak == 0.1 09:05:46 INFO - mozlog == 3.2 09:05:46 INFO - moznetwork == 0.27 09:05:46 INFO - mozprocess == 0.23 09:05:46 INFO - mozprofile == 0.28 09:05:46 INFO - mozrunner == 6.12 09:05:46 INFO - mozscreenshot == 0.1 09:05:46 INFO - mozsystemmonitor == 0.3 09:05:46 INFO - moztest == 0.7 09:05:46 INFO - mozversion == 1.4 09:05:46 INFO - psutil == 3.1.1 09:05:46 INFO - requests == 1.2.3 09:05:46 INFO - wsgiref == 0.1.2 09:05:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:46 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:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:46 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:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:46 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:46 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:05:46 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:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:46 INFO - 'HOME': '/Users/cltbld', 09:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:46 INFO - 'LOGNAME': 'cltbld', 09:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:46 INFO - 'MOZ_NO_REMOTE': '1', 09:05:46 INFO - 'NO_EM_RESTART': '1', 09:05:46 INFO - 'PAGER': '/bin/cat', 09:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:46 INFO - 'PWD': '/builds/slave/test', 09:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:46 INFO - 'SHELL': '/bin/bash', 09:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:46 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:46 INFO - 'USER': 'cltbld', 09:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:46 INFO - 'XPC_FLAGS': '0x0', 09:05:46 INFO - 'XPC_SERVICE_NAME': '0', 09:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 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:05:47 INFO - Cleaning up... 09:05:47 INFO - Return code: 0 09:05:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05:47 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:05:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 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:05:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:47 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 0x10437fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104414618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81b8d5b920>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, '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.GthjlbxKje/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.kCiU9WwSVo/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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:05:47 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:05:47 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:05:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:05:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:47 INFO - 'HOME': '/Users/cltbld', 09:05:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:47 INFO - 'LOGNAME': 'cltbld', 09:05:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:47 INFO - 'MOZ_NO_REMOTE': '1', 09:05:47 INFO - 'NO_EM_RESTART': '1', 09:05:47 INFO - 'PAGER': '/bin/cat', 09:05:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:47 INFO - 'PWD': '/builds/slave/test', 09:05:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:47 INFO - 'SHELL': '/bin/bash', 09:05:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:05:47 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:05:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:47 INFO - 'USER': 'cltbld', 09:05:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:47 INFO - 'XPC_FLAGS': '0x0', 09:05:47 INFO - 'XPC_SERVICE_NAME': '0', 09:05:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:47 INFO - Cleaning up... 09:05:47 INFO - Return code: 0 09:05:47 INFO - Running post-action listener: _resource_record_post_action 09:05:47 INFO - Running post-action listener: _start_resource_monitoring 09:05:47 INFO - Starting resource monitoring. 09:05:47 INFO - ##### 09:05:47 INFO - ##### Finished create-virtualenv step (success) 09:05:47 INFO - ##### 09:05:47 INFO - ##### 09:05:47 INFO - ##### Running install step. 09:05:47 INFO - ##### 09:05:47 INFO - Running pre-action listener: _resource_record_pre_action 09:05:47 INFO - Running main action method: install 09:05:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:47 INFO - Reading from file tmpfile_stdout 09:05:47 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:47 INFO - Reading from file tmpfile_stdout 09:05:47 INFO - Output received: 09:05:47 INFO - Usage: mozinstall [options] installer 09:05:47 INFO - Options: 09:05:47 INFO - -h, --help show this help message and exit 09:05:47 INFO - -d DEST, --destination=DEST 09:05:47 INFO - Directory to install application into. [default: 09:05:47 INFO - "/builds/slave/test"] 09:05:47 INFO - --app=APP Application being installed. [default: firefox] 09:05:47 INFO - mkdir: /builds/slave/test/build/application 09:05:47 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:05:47 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:06:22 INFO - Reading from file tmpfile_stdout 09:06:22 INFO - Output received: 09:06:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:06:22 INFO - Running post-action listener: _resource_record_post_action 09:06:22 INFO - ##### 09:06:22 INFO - ##### Finished install step (success) 09:06:22 INFO - ##### 09:06:22 INFO - ##### 09:06:22 INFO - ##### Running run-tests step. 09:06:22 INFO - ##### 09:06:22 INFO - Running pre-action listener: _resource_record_pre_action 09:06:22 INFO - Running main action method: run_tests 09:06:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:22 INFO - 2016-07-18 09:06:22.672 screenresolution[1640:8864] starting screenresolution argv=screenresolution get 09:06:22 INFO - 2016-07-18 09:06:22.675 screenresolution[1640:8864] Display 0: 1600x1200x32@60 09:06:22 INFO - 2016-07-18 09:06:22.681 screenresolution[1641:8866] starting screenresolution argv=screenresolution list 09:06:22 INFO - Available Modes on Display 0 09:06:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:22 INFO - Intel Iris: 09:06:22 INFO - Chipset Model: Intel Iris 09:06:22 INFO - Type: GPU 09:06:22 INFO - Bus: Built-In 09:06:22 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:22 INFO - Vendor: Intel (0x8086) 09:06:22 INFO - Device ID: 0x0a2e 09:06:22 INFO - Revision ID: 0x0009 09:06:22 INFO - Displays: 09:06:22 INFO - Display: 09:06:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:22 INFO - Display Serial Number: 1600x1200 60 09:06:22 INFO - Main Display: Yes 09:06:22 INFO - Mirror: Off 09:06:22 INFO - Online: Yes 09:06:22 INFO - Rotation: Supported 09:06:22 INFO - Return code: 0 09:06:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:22 INFO - Python 2.7.3 09:06:22 INFO - Return code: 0 09:06:22 INFO - grabbing minidump binary from tooltool 09:06: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:06:22 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 0x1042e3d30>, '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 0x104048db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1042dbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:22 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:06:22 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:06:22 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:06:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:23 INFO - Return code: 0 09:06:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:06:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:06:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0254', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0254 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:06:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GthjlbxKje/Render', 09:06:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:23 INFO - 'HOME': '/Users/cltbld', 09:06:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:23 INFO - 'LOGNAME': 'cltbld', 09:06:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:23 INFO - 'MOZ_NO_REMOTE': '1', 09:06:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:23 INFO - 'NO_EM_RESTART': '1', 09:06:23 INFO - 'PAGER': '/bin/cat', 09:06:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:23 INFO - 'PWD': '/builds/slave/test', 09:06:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:23 INFO - 'SHELL': '/bin/bash', 09:06:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kCiU9WwSVo/Listeners', 09:06:23 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 09:06:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:23 INFO - 'USER': 'cltbld', 09:06:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:23 INFO - 'XPC_FLAGS': '0x0', 09:06:23 INFO - 'XPC_SERVICE_NAME': '0', 09:06:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0254', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:06:23 INFO - mozversion application_buildid: 20160718065251 09:06:23 INFO - mozversion application_changeset: 1249782e3771430f4328851c1e8d198c204a4cd0 09:06:23 INFO - mozversion application_display_name: Nightly 09:06:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:23 INFO - mozversion application_name: Firefox 09:06:23 INFO - mozversion application_remotingname: firefox 09:06:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:06:23 INFO - mozversion application_vendor: Mozilla 09:06:23 INFO - mozversion application_version: 50.0a1 09:06:23 INFO - mozversion platform_buildid: 20160718065251 09:06:23 INFO - mozversion platform_changeset: 1249782e3771430f4328851c1e8d198c204a4cd0 09:06:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:06:23 INFO - mozversion platform_version: 50.0a1 09:06:23 INFO - using testdate: 1468857983 09:06:23 INFO - actual date: 1468857983 09:06:23 INFO - starting webserver on 'localhost:49276' 09:06:23 INFO - SUITE-START | Running 2 tests 09:06:23 INFO - TEST-START | dromaeo_css 09:06:23 INFO - operating with platform_type : mac_ 09:06:23 INFO - Initialising browser for dromaeo_css test... 09:06:23 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmp5ny87a/profile http://localhost:49276/getInfo.html) 09:06:25 INFO - PROCESS | 1651 | JavaScript error: , line 0: uncaught exception: undefined 09:06:26 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 09:06:26 INFO - PROCESS | 1651 | colorDepth:24 09:06:26 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 09:06:26 INFO - PROCESS | 1651 | __metrics 09:06:26 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:06:27 INFO - TEST-INFO | 1651: exit 0 09:06:27 INFO - Browser initialized. 09:06:27 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:27 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmp5ny87a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:39 INFO - PROCESS | 1655 | RSS: Main: 255975424 09:06:39 INFO - PROCESS | 1655 | 09:07:29 INFO - PROCESS | 1655 | 1468858049060 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:09:40 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 09:09:41 INFO - PROCESS | 1655 | RSS: Main: 268816384 09:09:41 INFO - PROCESS | 1655 | 09:12:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 09:12:44 INFO - PROCESS | 1655 | RSS: Main: 277037056 09:12:44 INFO - PROCESS | 1655 | 09:15:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 09:15:47 INFO - PROCESS | 1655 | RSS: Main: 281436160 09:15:47 INFO - PROCESS | 1655 | 09:18:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 09:18:49 INFO - PROCESS | 1655 | RSS: Main: 280309760 09:18:49 INFO - PROCESS | 1655 | 09:21:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 09:21:52 INFO - PROCESS | 1655 | RSS: Main: 284626944 09:21:52 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 09:24:55 INFO - PROCESS | 1655 | RSS: Main: 284274688 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | __start_tp_report 09:24:55 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 09:24:55 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 09:24:55 INFO - PROCESS | 1655 | |i|pagename|runs| 09:24:55 INFO - PROCESS | 1655 | |0;dojo.html;3476.391631464494;3480.4779283107546;3498;3500.2999400119984;3504.386732321843;5935.406459354068;5949.494292985096;5953.166556682063;6034.758609655609;6058.121572372014;5836.037053886114;5926.970365148169;5992.430719081691;5994.220751302325;6079.05774604937;4570.245909424958;5334.093204155303;5365.222042803791;5431.456854314557;5497.39528651848;444.5949420270769;5320.840374788762;5362.892742145154;5438.782448702047;5440.211169380437;5404.864878378033;5406.54044406224;5416.404195538487;5416.756245968941;5433.972830135864;5399.649022813504;5449.100898351767;5450.182472629098;5450.264214331054;5553.416891226444;5252.448492908228;5304.496072873109;5330.38700549434;5336.573074154097;5394.838154855361;5767.221425107598;5914.231149950522;5944.613600115978;6005.6997150142315;6011.248593925759;6164.106204600308;6199.50403967686;6246.875062498724;6261.624302541816;6273.96863015682;6265.122882796412;6304;6338.556301058928;6381.904271435932;6381.968090159566;6063.060225665029;6111.266648002268;6122.693865306762;6124.663143527059;6141.692915354214;6257.405546473078;6415.26224484181;6545.639989800511;6565.606063636197;6579.111819904348;6185.8144255672405;6194.163787888578;6221.097940798559;6247.718852651642;6259.624422534663;6282.151909492251;6358.745650173942;6362.840928976812;6397.52018598607;6398.936010639927;6161.568690191643;6168.167297414881;6205.162303089115;6231.065340199007;6286.182796236551;6227.470664993526;6236.376362363727;6255.311915689271;6264.843378915563;6272.435480806749;3986.940195897064;5073.847784566469;5074.619403544749;5079.644424890296;5083.212102124176;4399.318105693623;4480.462344518679;4481.910361792811;4502.932456013163;4527.705699129546;6026.819195424145;6036.879262414727;6088.939110608926;6094.8943112006145;6127.601705889103;6325.367463253638;6417.26201486835;6417.326180750954;6420;6424.068510066014;5905.911411328833;6031.788887388921;6105.50568046402;6109.389061093944;6139.907901381483;5637.126245431965;5640.605157639008;5648.4633959773755;5650.5479561634975;5652.265205523256;5537.501624853782;6312.747490100344;6600.5049621278595;6608.107905432705;6615.17310336208;6272.749090036347;6299.559030867796;6334.809955701337;6363.745450182126;6397.584157029778;6583.736650533925;6587.934120658923;6593.670316484061;6602.867942641216;6617.272100069084;6181.041938499539;6197.163382943425;6278.623282603058;6282.623042617275;6299.275583307978;6194.783182588588;6284.308726040041;6347.841303967438;6351.2696039956;6355.237371515448;5158.38099428071;6141.709538774048;6205.720742566686;6208.9689551551955;6217.658028808459;5152.458991805806;6172.105044768573;6178.969105154445;6217.751289948352;6249.78125765596;5678.432156784289;6151.477124444294;6210.5652604317265;6227.532935029801;6232.439080482778;6194.086013466726;6200.472959798468;6214.067889816563;6219.284782250099;6234.2830574482705;6099.573029887865;6107.249501910372;6119.593952096866;6127.708789263955;6208.441240288395 09:24:55 INFO - PROCESS | 1655 | |1;ext.html;472.84868841970575;486.6252985201397;508.7710530261383;539.8029719152511;569.0724119684913;38413.61586384139;40924.79537602312;40996.38505422417;41041.97395065125;41302;41651;41828.58171418285;42276.788616056954;42392.78803605978;42622.57377426225;9453.574589143487;9659.951700241489;9680.499522574013;9681.806363872718;9693.3699309545;9676.467794271312;9693.75765605862;9705.41767493949;9714.36856604322;9747.512624368788;9753.902460975405;9778.413295202276;9807.362521436084;9831;9838.606455741761;9705.320627556073;9724.61101555944;9737.853932191023;9741.074597913257;9753.756156096084;9684.854727179098;9721.368111072828;9742.464164470952;9761.974992625743;9769.023097690175;39346.21307573833;39612.00969975745;39838.203235935405;40142;40178;3010.834404107773;3104;3204.3110731192905;3498.982505087484;3571.6785489305826;29512.704872951424;29726.171015169555;30403.935862244714;31102.844485777652;31756.20609484758;2553.489302139561;3173.809571425699;3193.552902593639;3218.6781321867625;3294.3246634439884;382368.0881595602;441245.7937710323;442810;442906;448715;33171.170720731694;33322.166945826066;33360.666393335756;33481.497777533354;33504.66495335064;34971.65028349735;35089.1227719309;35400.64599354025;35719.4642080369;35912;16439.83560164407;16719.247633856507;16737.581560461087;16892.662146756997;16896.239669214916;12574.622761317176;12787.10490265691;12852.807207891889;12891.484340626457;12916.935415322863;19728.90135549313;19815.009249537467;19888.602227955358;19931;20244;6876.69054892531;8282.544460054754;8288.50268983863;8302.916970830214;8377.329813614897;886.3573908915985;994.4629899854142;1029.984550231747;1062.6068354708807;1064.11678307005;30594;30941.535876961865;31062.038916670615;31080.844595776878;31097.53353699696;886.6586364249811;970.5341436110565;1017.9796404071877;1091.8034753744403;1137.3403426012892;15986.840131598768;16025.679486410207;16148.27332770028;16169.434069807501;16420.425285114965;643693;648560;658919;661981;663132;59308.40691593029;59834.10248846271;59891;59997.80004399975;60072.69963650241;1320.8084827700122;1359.306753555674;1360.7618666733283;1371.8696723811222;1381.979270310946;30080.3983920316;30284;30553.388932220787;30749;31156.22109447282;50832.74583627058;50870.23694644509;51061.404473597555;51120.48879511306;51399.743001284754;595841;619905;622430;623734.8813255904;625237;26884;26940.865295673397;27038.594421083308;27176.320591985357;27311.180664580093;47962.520374797205;48497.7875553114;49144.52566423013;49312;49450.75274623604;39361.40957885691;40377.1924561513;40610.78167654975;41495.377569335884;41952;40228.396574052;40449.595504044584;40617.796911015255;41076.178476430905;41319.58680413278;33278.334433311684;38512.844614661604;38523.80738096291;38993.610063898996;39249.21501569895;29971;30446.84776576103;32905.835470822494;35271.294574108884;35420;23369.948352324525;23673.40816479602;25850;26080.8695956519;26696.19911402661 09:24:55 INFO - PROCESS | 1655 | |2;jquery.html;383.70071344351396;385.7280617164899;390.69068177996706;391.1102242398543;410.32296710427806;15012.324445399956;20456.18175272989;20831;21740.130394784228;21836.672449913265;20585.588288234227;20721.274755383565;20798.272060477888;21222.89388553055;21223;5882.9998900186965;6106.114613381057;6106.267247930255;6121.632702037892;6121.816345509642;5939.584229103964;5997.820065398045;6061.66660833654;6071.0589858571775;6128.693565321716;5878.088896221093;5983.760649574012;6040.0939859021055;6050.394960503936;6062.727177277033;5929.466348028676;5998.910016349736;6037.698115094272;6075.908861367083;6079.20970273866;5269.394019687708;5274.736263186825;5291.920621190685;5292.867678308035;5295.4704529547125;24485.63271550928;25665.230043098738;25885.35286617831;26012.219633411027;26290.73709262902;2323.3262353917344;2341.4029422497324;2495.1516484395393;2550.196688043279;3047;9711.125998660154;10357.741056473573;15110.320035598425;15623.609409764733;16038.839611603968;1629.4541328654914;1660.9750853737203;1911.2832687742098;1917.5685470768965;1975.1309423853459;107053;124169;128643.35678321548;131248.6875131246;131352;9509.857352139723;11672.949434550932;11687.123465739933;11702.824457633142;11732.70668233301;12789.296588687526;14656.706865862623;14708.235011798439;14744.705105897821;14801.629959251104;8145.226203510775;8217.178282171735;8325.916740832514;8398.454100483448;8459.957700211582;6674.632895190714;8050.27547520726;8152.307053900485;8235.95882020598;8257.917420825836;3990.20195960809;4449.243628583149;4506.504284528699;4542.863714088517;4580.152671755736;1619.4574817436292;1969.8030196980474;1971.5662554238045;1988.413418041681;2013.3959812056617;932.7201839448138;947.9715608531617;954.8901876284177;1002.6139936124499;1022.8363461846069;20814.895925520275;21134.048967796487;21137.260195893068;21221;21338.466538336666;951.7620594851287;954.2699834626517;955.254901177083;976.1800087926176;1063.4948399510172;10913.890861091446;11254.38100904458;11316.886831131747;11319.603813866475;11351.432428378548;545795;579454;614222.9288853616;627398;634585;79480.60259698665;88312.55843720741;140839;141729.29135354463;144528;964.2382517810851;1010.3432768700403;1010.5654568535454;1022.5756311130946;1036.6268143468346;18958.52603684919;19049.809501904805;19187.712184316966;19406.417807465798;19547.413577592695;56905;57792;57915;58478.41521584729;59245;84473;84620;84909.30181396462;85429.57285213534;86738;6418.614883107029;6933.786587347295;8075.555844428378;8233.711820086268;8415.200555947175;12575;13079.738405232032;13624.863751362756;13763.105398149088;13879.306034698428;11495.597654082067;11572;11574.6527604172;11614.361210133524;11773.76452470963;9677.854832177381;11604.07167426587;11644.88355116438;11752.882471175179;11785.175037747274;11713.238639488405;11851.466683999068;11980.161388702707;12006.459709313276;12057.336846473529;8278.71024514139;8331.208535189147;8383.119772424052;8444.113368096261;8506.362022848434;10421.218408619232;10430.947845260725;11543.76912461763;11687.88312116868;11714.062874969812 09:24:55 INFO - PROCESS | 1655 | |3;mootools.html;1460.700556385941;1568.059164501299;1817.145941407538;1902.3722171683346;1949.5028767664244;7145.857082858346;8072.515649061061;8597.785055373619;9081.682141125053;9121.042290559495;8720.433171843826;8774.868376974351;8815.603297851596;8874.822503549925;8895.95552022239;2382.356763673811;2403.2790162951133;2413.806895448369;2417.7703118203744;2422.454947636785;2393.3179043972473;2400.147947478646;2421.8667973261463;2427.490227052321;2438.902443902242;2090.7491101067894;2400.6279026750794;2418.8790560471994;2424.866632335221;2436.1838784007377;2244.6408574628144;2390.151496218835;2395.4250979764906;2400.59189937711;2408.0728919366084;2230.0410823345956;2377.869217193054;2390.521895620883;2404.5912194926727;2413.1674572272536;8892.066333035003;9006.06369630526;9025.23285520725;9027.4132181408;9058.094190580956;5357.598180136505;5484.91772623411;5500.669959802384;5502.779888804443;5505.119180931032;3583.7312201584723;3707.3326801175776;3750;3765.2093060457337;3783.39465685489;1099.395332567085;1100.625787232345;1112.2214449885112;1116.3357802107732;1124.9212555121144;10699.679009629723;11194.544709187754;11751;11899.583514576949;11912.34482103484;4473.530279320689;4515.0518391137575;4684.554967278172;4689.577937985598;4693.7653117344;9161.633534658538;9238.95380523093;9246.398984066014;9253.537323133816;9270.165685088374;5303.416624171338;5318.308619879391;5322.973385133127;5329.173978033411;5331.5201631853315;4442.489113751895;4795.352627395257;4968.080905032581;4977.377827771528;4981.701097934136;3285.9791228394365;3845.4808600839087;3893.7274390792372;3915.882523524299;3954.387070004154;1027.4246422003553;1179.728662407651;1185.4191446191305;1186.9969875455226;1188.3107797477442;772.97681069568;936.8782058332373;944.3719926249105;950.9381890177254;974.0940924939874;5410.296661434067;5571.498565129158;5859.560532960045;6067.575269731076;6187.783427580013;422.1283050500706;435.28178505465604;443.1159836126947;448.5447271019917;453.7935239466035;4101.892489027946;4123.092919557693;4166.250074986471;4182.372644103348;4201.68487363449;10225.284230103822;10923.563057477611;11004.834927476095;11032.779344413068;11042.227044106836;10301.381917084998;10595.788084238273;10802.08182304513;10949.781004379867;11072.114230861513;8353.916460835313;8407.495550267126;8445.155484451629;8445.95777021111;8471.745847624581;5959.851003724768;5962.25471816023;5967.9701601491715;6104.572679912541;6198.690065496798;9976.451295178835;10037.046480584333;10271.075603195748;10293.691189264335;10321.535530901278;10226.437545935045;10399.58401663925;10406.791864162826;10408.271421000458;10422.530986105492;5446.673199608036;6537.444317232898;7114.181869085121;7126;7198.316159964795;8499;8520.14798520143;8550.1449855014;8598.140185981601;8600.053994060774;7565.773026809205;7651.311381975649;7658.004459420463;7760.30157285847;7812.257835505618;7490.887636685563;7597.164311925794;7598.582077985543;7723.034620672416;7750.147483776667;7114.075170227838;7144.24985376528;7163.892541611775;7205.7838264852135;7207.9639601801655;5023.899522009612;5111.923321150111;5145.974270128625;5200.167973124282;5207.92188117171;5176.922346164735;5191.091558977239;5192.169252919514;5247.737613119405;5329.280547126088 09:24:55 INFO - PROCESS | 1655 | |4;prototype.html;304.3836231630947;309.8667572943634;317.83631429813653;318.7848202463338;320.0797706593544;5272.420033796289;5467.726613669321;5707.828765137047;5818.621789583674;5894.086416605428;5653.293338332708;5662.433756624336;5665.490105890469;5665.603407761459;5696.800611978581;3605.891823245307;3662.52387189665;4062.735922165057;4370.082282720617;4394.780260986954;3469.809160496172;3638.508801311829;4180.6237438630515;4300.8085718537595;4377.6292254963655;3311.3708395404915;3735.234276973214;4164.27125253081;4189.371594260855;4280.3151495760685;3682.5396825396824;4285.57144285572;4316.223079845627;4319.676024298159;4340.066885619607;3242;3332.583427071616;3574.3363052871014;3746.2320224353944;3750.643688849555;4745.857624271277;5326.520613144836;5512.503874651261;5535.086710692731;5693.572982026365;4301.634361079312;4396.956030439686;4656.417947756497;4764.404449443819;4840.233314840093;5008.373953255843;6021.397860213988;6046.27444706638;6048.6410299983045;6086.33050364464;3552.502649629054;3665.9450108248398;3700.5559332880225;3755.361588529929;4011.1576568920564;6037.879242415171;6112.297085835142;6298.527610429191;6306.747730090791;6340.841478963017;4012.3348810244006;4019.738716983387;4025.295573274665;4025.376066709665;4052.2705912935953;3774.1130834253927;3788.8673896413493;4119.546849846514;4119.938200926988;4121.567235440296;4104.994276402301;4587.564181402761;4762.380890484214;4870.05034018363;4886.068358984652;4960.875978100504;5241.633085683966;6013.789517366871;6022.488088512438;6037.547183961133;1291.9147915750814;1367.6922692394132;1392.958211253664;1396.2669598460889;1401.85981401859;770.942179336552;771.4869611708151;812.3582369927691;850.9191626795445;862.4609618988133;4561.29299958507;4727.692699974491;4732.337472753818;4808.975955120202;4816.759162041954;4717.263986887597;4832.637552183601;5197.714125723046;5249.42256351801;5332.92000619991;4160.439835061852;4304.591063848992;4751.548602882721;4763.903882291781;4770.95229047712;2462.9753702463104;2503.849769013865;2625.5142798582324;2634.841909485437;2764.8940423830627;4348.152110338454;4442.68901176921;5122.641415100981;5150.793968241303;5400.864978375494;5039.4708555601865;5157.4584668610005;5319.5744340452675;5405.621606487587;5406.702631355313;4812.470628230962;5381.112116500812;5394.217838413408;5437.972810136003;5443.455654434604;4786.181251124551;5170.716594962151;5221.895562088661;5237.738113094406;5297.642549065783;4341.305391137403;4856.902861942812;5093.719845408538;5102.897942041064;5166.509181627739;4645.465771436328;5280.0463828383745;5739.483446489836;5912.782706485068;6224.284207316216;3409.573803274591;3561.3767590672046;3575.8021062944204;3789.6020917803235;4033.2135233630333;5349.866253343542;5683.2895888014;5729.054705973468;5948.21867658876;6190.81427557174;4826.734529600905;5776;5983.640981541122;6015.819525414245;6053.061775424816;5405;5583.855309661591;5985.4912332450485;6023.5181185505935;6031.7587296507645;5611.915821262603;5833.941660583339;5891.469767720926;5898.262717160355;5898.469137777621;5916.674582897982;5969.91045134332;5974.074018527135;5989.970050149721;6044;4868.902621947612;5182.689038657692;5866.002779527405;5881.353051164283;5929.644221346733 09:24:55 INFO - PROCESS | 1655 | |5;yui.html;656.4977791989129;716.1942814333871;741.077358688433;792.7106606088776;848.5417874347852;15502.922485387571;15600.609984750387;16169.19154042296;16181.352745890179;16189.919050404746;14738.336774845131;14884.479043233488;14896.776548351756;14917.92541037296;14926.925365373158;612.2285919741136;746.940244780419;877.4165180155189;890.4167770110588;902.0573500691793;901.5041727050129;901.9503927283997;904.2901322461836;907.4645958884257;909.4497828813571;956.1681337236614;961.6634178037701;962.1869520255408;962.6534447598859;964.2141654551554;919.6689191890981;949.4018768176074;955.1546881010287;955.3408148377632;956.9617215311379;705.3264132753209;708.6563016936782;710.1655554723179;710.2790667472519;712.1240873725346;13391.263480508567;13986.230757308344;14811.111333319928;14875.330610122463;14963.625909352353;12398.876011239952;13248.873845723125;14278.928605356907;15159.696806063926;15322.23388830565;11957;11985.520579176822;12046;12102.273863568214;12236.388180590935;3331.200511877132;3502.0019294500944;3813.31360355136;3948.5261768587666;3952.920941581181;114573.68836804644;115495;116524;118141;119111;11589.942050289694;11654.650360489199;11735;11759.941200294115;12075.51697932073;24363.512729745307;24388.390290242885;24402.26793196207;24403.023879044995;24440.511189776462;8283.95858020706;8354.143924553497;8413;8431.15688431152;8465.89943307366;4515.14212299662;4555.339475775994;4582.862514124582;4599.356090147382;4607.170709272363;3639.7998110103667;3738.065483629093;3750.83121259544;3753.5683396409763;3762.3792074307435;666.7599664120912;669.1234482827414;679.6160169504215;681.877262092828;683.9452843772486;620.6648409858716;673.7406098651957;676.7631329034798;689.941354984832;690.4821383962028;9185.311101667401;9656.082672146134;9807.313488055768;9847.310688251897;9976.950115249378;622.3496446213718;649.909012738217;679.5141473846223;682.068975847964;718.5544962123413;4099.221147981874;4154.563770804082;4408.404865343137;4549.727016379028;4645;141939.29030354987;146339;148319;151019;155251;131360;131539.3961211353;133847;134850;137802;74636.62681686557;75446.24553754502;75835;106428;119498.99999999827;6958.617276049866;8753.91246087531;8830.470171789713;8838.558072096497;8908.198262156437;42329.57670423256;60060.79878402495;64752;65840.68318633696;67498.98751518632;83832;97243;98978.01021989688;99476;99590;11466.541338346373;13557.389917453542;13702.314884255948;13789.586312410644;14213.289335532974;15163.924180379468;15216.239188040332;15439;15625.374985000473;15740.68518629644;14110.576682699535;14327.928360358132;14331.85668143347;14619.269036548343;14773.630659233606;14302.856971430152;14594.416223350947;14765.852341476448;14809.777853331992;14811.92594037066;13952.720945580828;14081;14241.928790355982;14439.422423102958;14490.203038832966;11422.428878555873;11431.594075611894;11796.52813887435;11876.940615296868;11926.642200733992;10752.193585481276;10923.508442120283;11502.654920352403;11861.881381186078;11884.405779711153 09:24:55 INFO - PROCESS | 1655 | __end_tp_report 09:24:55 INFO - PROCESS | 1655 | __start_cc_report 09:24:55 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,450 09:24:55 INFO - PROCESS | 1655 | __end_cc_report 09:24:55 INFO - PROCESS | 1655 | __startTimestamp1468859095658__endTimestamp 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | ------- Summary: start ------- 09:24:55 INFO - PROCESS | 1655 | Number of tests: 6 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5853.63 Median:6141.69 stddev:782.35 (12.7%) stddev-sans-first:762.20 09:24:55 INFO - PROCESS | 1655 | Values: 3476.4 3480.5 3498.0 3500.3 3504.4 5935.4 5949.5 5953.2 6034.8 6058.1 5836.0 5927.0 5992.4 5994.2 6079.1 4570.2 5334.1 5365.2 5431.5 5497.4 444.6 5320.8 5362.9 5438.8 5440.2 5404.9 5406.5 5416.4 5416.8 5434.0 5399.6 5449.1 5450.2 5450.3 5553.4 5252.4 5304.5 5330.4 5336.6 5394.8 5767.2 5914.2 5944.6 6005.7 6011.2 6164.1 6199.5 6246.9 6261.6 6274.0 6265.1 6304.0 6338.6 6381.9 6382.0 6063.1 6111.3 6122.7 6124.7 6141.7 6257.4 6415.3 6545.6 6565.6 6579.1 6185.8 6194.2 6221.1 6247.7 6259.6 6282.2 6358.7 6362.8 6397.5 6398.9 6161.6 6168.2 6205.2 6231.1 6286.2 6227.5 6236.4 6255.3 6264.8 6272.4 3986.9 5073.8 5074.6 5079.6 5083.2 4399.3 4480.5 4481.9 4502.9 4527.7 6026.8 6036.9 6088.9 6094.9 6127.6 6325.4 6417.3 6417.3 6420.0 6424.1 5905.9 6031.8 6105.5 6109.4 6139.9 5637.1 5640.6 5648.5 5650.5 5652.3 5537.5 6312.7 6600.5 6608.1 6615.2 6272.7 6299.6 6334.8 6363.7 6397.6 6583.7 6587.9 6593.7 6602.9 6617.3 6181.0 6197.2 6278.6 6282.6 6299.3 6194.8 6284.3 6347.8 6351.3 6355.2 5158.4 6141.7 6205.7 6209.0 6217.7 5152.5 6172.1 6179.0 6217.8 6249.8 5678.4 6151.5 6210.6 6227.5 6232.4 6194.1 6200.5 6214.1 6219.3 6234.3 6099.6 6107.2 6119.6 6127.7 6208.4 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:69002.82 Median:39725.11 stddev:154439.28 (388.8%) stddev-sans-first:154786.81 09:24:55 INFO - PROCESS | 1655 | Values: 472.8 486.6 508.8 539.8 569.1 38413.6 40924.8 40996.4 41042.0 41302.0 41651.0 41828.6 42276.8 42392.8 42622.6 9453.6 9660.0 9680.5 9681.8 9693.4 9676.5 9693.8 9705.4 9714.4 9747.5 9753.9 9778.4 9807.4 9831.0 9838.6 9705.3 9724.6 9737.9 9741.1 9753.8 9684.9 9721.4 9742.5 9762.0 9769.0 39346.2 39612.0 39838.2 40142.0 40178.0 3010.8 3104.0 3204.3 3499.0 3571.7 29512.7 29726.2 30403.9 31102.8 31756.2 2553.5 3173.8 3193.6 3218.7 3294.3 382368.1 441245.8 442810.0 442906.0 448715.0 33171.2 33322.2 33360.7 33481.5 33504.7 34971.7 35089.1 35400.6 35719.5 35912.0 16439.8 16719.2 16737.6 16892.7 16896.2 12574.6 12787.1 12852.8 12891.5 12916.9 19728.9 19815.0 19888.6 19931.0 20244.0 6876.7 8282.5 8288.5 8302.9 8377.3 886.4 994.5 1030.0 1062.6 1064.1 30594.0 30941.5 31062.0 31080.8 31097.5 886.7 970.5 1018.0 1091.8 1137.3 15986.8 16025.7 16148.3 16169.4 16420.4 643693.0 648560.0 658919.0 661981.0 663132.0 59308.4 59834.1 59891.0 59997.8 60072.7 1320.8 1359.3 1360.8 1371.9 1382.0 30080.4 30284.0 30553.4 30749.0 31156.2 50832.7 50870.2 51061.4 51120.5 51399.7 595841.0 619905.0 622430.0 623734.9 625237.0 26884.0 26940.9 27038.6 27176.3 27311.2 47962.5 48497.8 49144.5 49312.0 49450.8 39361.4 40377.2 40610.8 41495.4 41952.0 40228.4 40449.6 40617.8 41076.2 41319.6 33278.3 38512.8 38523.8 38993.6 39249.2 29971.0 30446.8 32905.8 35271.3 35420.0 23369.9 23673.4 25850.0 26080.9 26696.2 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:35533.29 Median:2522.67 stddev:100466.19 (3982.5%) stddev-sans-first:100713.36 09:24:55 INFO - PROCESS | 1655 | Values: 383.7 385.7 390.7 391.1 410.3 15012.3 20456.2 20831.0 21740.1 21836.7 20585.6 20721.3 20798.3 21222.9 21223.0 5883.0 6106.1 6106.3 6121.6 6121.8 5939.6 5997.8 6061.7 6071.1 6128.7 5878.1 5983.8 6040.1 6050.4 6062.7 5929.5 5998.9 6037.7 6075.9 6079.2 5269.4 5274.7 5291.9 5292.9 5295.5 24485.6 25665.2 25885.4 26012.2 26290.7 2323.3 2341.4 2495.2 2550.2 3047.0 9711.1 10357.7 15110.3 15623.6 16038.8 1629.5 1661.0 1911.3 1917.6 1975.1 107053.0 124169.0 128643.4 131248.7 131352.0 9509.9 11672.9 11687.1 11702.8 11732.7 12789.3 14656.7 14708.2 14744.7 14801.6 8145.2 8217.2 8325.9 8398.5 8460.0 6674.6 8050.3 8152.3 8236.0 8257.9 3990.2 4449.2 4506.5 4542.9 4580.2 1619.5 1969.8 1971.6 1988.4 2013.4 932.7 948.0 954.9 1002.6 1022.8 20814.9 21134.0 21137.3 21221.0 21338.5 951.8 954.3 955.3 976.2 1063.5 10913.9 11254.4 11316.9 11319.6 11351.4 545795.0 579454.0 614222.9 627398.0 634585.0 79480.6 88312.6 140839.0 141729.3 144528.0 964.2 1010.3 1010.6 1022.6 1036.6 18958.5 19049.8 19187.7 19406.4 19547.4 56905.0 57792.0 57915.0 58478.4 59245.0 84473.0 84620.0 84909.3 85429.6 86738.0 6418.6 6933.8 8075.6 8233.7 8415.2 12575.0 13079.7 13624.9 13763.1 13879.3 11495.6 11572.0 11574.7 11614.4 11773.8 9677.9 11604.1 11644.9 11752.9 11785.2 11713.2 11851.5 11980.2 12006.5 12057.3 8278.7 8331.2 8383.1 8444.1 8506.4 10421.2 10430.9 11543.8 11687.9 11714.1 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5739.52 Median:4881.72 stddev:3222.06 (66.0%) stddev-sans-first:3215.05 09:24:55 INFO - PROCESS | 1655 | Values: 1460.7 1568.1 1817.1 1902.4 1949.5 7145.9 8072.5 8597.8 9081.7 9121.0 8720.4 8774.9 8815.6 8874.8 8896.0 2382.4 2403.3 2413.8 2417.8 2422.5 2393.3 2400.1 2421.9 2427.5 2438.9 2090.7 2400.6 2418.9 2424.9 2436.2 2244.6 2390.2 2395.4 2400.6 2408.1 2230.0 2377.9 2390.5 2404.6 2413.2 8892.1 9006.1 9025.2 9027.4 9058.1 5357.6 5484.9 5500.7 5502.8 5505.1 3583.7 3707.3 3750.0 3765.2 3783.4 1099.4 1100.6 1112.2 1116.3 1124.9 10699.7 11194.5 11751.0 11899.6 11912.3 4473.5 4515.1 4684.6 4689.6 4693.8 9161.6 9239.0 9246.4 9253.5 9270.2 5303.4 5318.3 5323.0 5329.2 5331.5 4442.5 4795.4 4968.1 4977.4 4981.7 3286.0 3845.5 3893.7 3915.9 3954.4 1027.4 1179.7 1185.4 1187.0 1188.3 773.0 936.9 944.4 950.9 974.1 5410.3 5571.5 5859.6 6067.6 6187.8 422.1 435.3 443.1 448.5 453.8 4101.9 4123.1 4166.3 4182.4 4201.7 10225.3 10923.6 11004.8 11032.8 11042.2 10301.4 10595.8 10802.1 10949.8 11072.1 8353.9 8407.5 8445.2 8446.0 8471.7 5959.9 5962.3 5968.0 6104.6 6198.7 9976.5 10037.0 10271.1 10293.7 10321.5 10226.4 10399.6 10406.8 10408.3 10422.5 5446.7 6537.4 7114.2 7126.0 7198.3 8499.0 8520.1 8550.1 8598.1 8600.1 7565.8 7651.3 7658.0 7760.3 7812.3 7490.9 7597.2 7598.6 7723.0 7750.1 7114.1 7144.2 7163.9 7205.8 7208.0 5023.9 5111.9 5146.0 5200.2 5207.9 5176.9 5191.1 5192.2 5247.7 5329.3 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4552.30 Median:4878.06 stddev:1433.53 (29.4%) stddev-sans-first:1401.64 09:24:55 INFO - PROCESS | 1655 | Values: 304.4 309.9 317.8 318.8 320.1 5272.4 5467.7 5707.8 5818.6 5894.1 5653.3 5662.4 5665.5 5665.6 5696.8 3605.9 3662.5 4062.7 4370.1 4394.8 3469.8 3638.5 4180.6 4300.8 4377.6 3311.4 3735.2 4164.3 4189.4 4280.3 3682.5 4285.6 4316.2 4319.7 4340.1 3242.0 3332.6 3574.3 3746.2 3750.6 4745.9 5326.5 5512.5 5535.1 5693.6 4301.6 4397.0 4656.4 4764.4 4840.2 5008.4 6021.4 6046.3 6048.6 6086.3 3552.5 3665.9 3700.6 3755.4 4011.2 6037.9 6112.3 6298.5 6306.7 6340.8 4012.3 4019.7 4025.3 4025.4 4052.3 3774.1 3788.9 4119.5 4119.9 4121.6 4105.0 4587.6 4762.4 4870.1 4886.1 4960.9 5241.6 6013.8 6022.5 6037.5 1291.9 1367.7 1393.0 1396.3 1401.9 770.9 771.5 812.4 850.9 862.5 4561.3 4727.7 4732.3 4809.0 4816.8 4717.3 4832.6 5197.7 5249.4 5332.9 4160.4 4304.6 4751.5 4763.9 4771.0 2463.0 2503.8 2625.5 2634.8 2764.9 4348.2 4442.7 5122.6 5150.8 5400.9 5039.5 5157.5 5319.6 5405.6 5406.7 4812.5 5381.1 5394.2 5438.0 5443.5 4786.2 5170.7 5221.9 5237.7 5297.6 4341.3 4856.9 5093.7 5102.9 5166.5 4645.5 5280.0 5739.5 5912.8 6224.3 3409.6 3561.4 3575.8 3789.6 4033.2 5349.9 5683.3 5729.1 5948.2 6190.8 4826.7 5776.0 5983.6 6015.8 6053.1 5405.0 5583.9 5985.5 6023.5 6031.8 5611.9 5833.9 5891.5 5898.3 5898.5 5916.7 5969.9 5974.1 5990.0 6044.0 4868.9 5182.7 5866.0 5881.4 5929.6 09:24:55 INFO - PROCESS | 1655 | 09:24:55 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:24951.06 Median:3744.45 stddev:39575.49 (1056.9%) stddev-sans-first:39644.47 09:24:55 INFO - PROCESS | 1655 | Values: 656.5 716.2 741.1 792.7 848.5 15502.9 15600.6 16169.2 16181.4 16189.9 14738.3 14884.5 14896.8 14917.9 14926.9 612.2 746.9 877.4 890.4 902.1 901.5 902.0 904.3 907.5 909.4 956.2 961.7 962.2 962.7 964.2 919.7 949.4 955.2 955.3 957.0 705.3 708.7 710.2 710.3 712.1 13391.3 13986.2 14811.1 14875.3 14963.6 12398.9 13248.9 14278.9 15159.7 15322.2 11957.0 11985.5 12046.0 12102.3 12236.4 3331.2 3502.0 3813.3 3948.5 3952.9 114573.7 115495.0 116524.0 118141.0 119111.0 11589.9 11654.7 11735.0 11759.9 12075.5 24363.5 24388.4 24402.3 24403.0 24440.5 8284.0 8354.1 8413.0 8431.2 8465.9 4515.1 4555.3 4582.9 4599.4 4607.2 3639.8 3738.1 3750.8 3753.6 3762.4 666.8 669.1 679.6 681.9 683.9 620.7 673.7 676.8 689.9 690.5 9185.3 9656.1 9807.3 9847.3 9977.0 622.3 649.9 679.5 682.1 718.6 4099.2 4154.6 4408.4 4549.7 4645.0 141939.3 146339.0 148319.0 151019.0 155251.0 131360.0 131539.4 133847.0 134850.0 137802.0 74636.6 75446.2 75835.0 106428.0 119499.0 6958.6 8753.9 8830.5 8838.6 8908.2 42329.6 60060.8 64752.0 65840.7 67499.0 83832.0 97243.0 98978.0 99476.0 99590.0 11466.5 13557.4 13702.3 13789.6 14213.3 15163.9 15216.2 15439.0 15625.4 15740.7 14110.6 14327.9 14331.9 14619.3 14773.6 14302.9 14594.4 14765.9 14809.8 14811.9 13952.7 14081.0 14241.9 14439.4 14490.2 11422.4 11431.6 11796.5 11876.9 11926.6 10752.2 10923.5 11502.7 11861.9 11884.4 09:24:55 INFO - PROCESS | 1655 | -------- Summary: end -------- 09:24:55 INFO - PROCESS | 1655 | 09:24:56 INFO - TEST-INFO | 1655: exit 0 09:24:56 INFO - TEST-OK | dromaeo_css | took 1113039ms 09:24:56 INFO - TEST-START | kraken 09:24:56 INFO - operating with platform_type : mac_ 09:24:56 INFO - Initialising browser for kraken test... 09:24:56 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmpTJpUzZ/profile http://localhost:49276/getInfo.html) 09:24:58 INFO - PROCESS | 1663 | JavaScript error: , line 0: uncaught exception: undefined 09:24:59 INFO - PROCESS | 1663 | __metrics Screen width/height:1600/1200 09:24:59 INFO - PROCESS | 1663 | colorDepth:24 09:24:59 INFO - PROCESS | 1663 | Browser inner width/height: 1024/689 09:24:59 INFO - PROCESS | 1663 | __metrics 09:24:59 ERROR - PROCESS | 1663 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 09:25:00 INFO - TEST-INFO | 1663: exit 0 09:25:00 INFO - Browser initialized. 09:25:00 INFO - Running cycle 1/1 for kraken test... 09:25:00 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmpTJpUzZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:12 INFO - PROCESS | 1665 | RSS: Main: 255836160 09:25:12 INFO - PROCESS | 1665 | 09:25:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:15 INFO - PROCESS | 1665 | RSS: Main: 268763136 09:25:15 INFO - PROCESS | 1665 | 09:25:18 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 09:25:18 INFO - PROCESS | 1665 | RSS: Main: 272318464 09:25:18 INFO - PROCESS | 1665 | 09:25:22 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 09:25:23 INFO - PROCESS | 1665 | RSS: Main: 273084416 09:25:23 INFO - PROCESS | 1665 | 09:25:24 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 09:25:25 INFO - PROCESS | 1665 | RSS: Main: 274022400 09:25:25 INFO - PROCESS | 1665 | 09:25:27 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:28 INFO - PROCESS | 1665 | RSS: Main: 274735104 09:25:28 INFO - PROCESS | 1665 | 09:25:31 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:32 INFO - PROCESS | 1665 | RSS: Main: 275255296 09:25:32 INFO - PROCESS | 1665 | 09:25:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:35 INFO - PROCESS | 1665 | RSS: Main: 275673088 09:25:35 INFO - PROCESS | 1665 | 09:25:38 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 09:25:39 INFO - PROCESS | 1665 | RSS: Main: 275578880 09:25:39 INFO - PROCESS | 1665 | 09:25:41 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:41 INFO - PROCESS | 1665 | RSS: Main: 275496960 09:25:41 INFO - PROCESS | 1665 | 09:25:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:44 INFO - PROCESS | 1665 | RSS: Main: 275132416 09:25:44 INFO - PROCESS | 1665 | 09:25:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:47 INFO - PROCESS | 1665 | RSS: Main: 275169280 09:25:47 INFO - PROCESS | 1665 | 09:25:50 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:50 INFO - PROCESS | 1665 | RSS: Main: 275353600 09:25:50 INFO - PROCESS | 1665 | 09:25:53 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:54 INFO - PROCESS | 1665 | RSS: Main: 275337216 09:25:54 INFO - PROCESS | 1665 | 09:25:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 09:25:56 INFO - PROCESS | 1665 | RSS: Main: 276279296 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | __start_tp_report 09:25:56 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 09:25:56 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 09:25:56 INFO - PROCESS | 1665 | |i|pagename|runs| 09:25:56 INFO - PROCESS | 1665 | |0;ai-astar;106;167;115;117;118;119;114;116;115;117 09:25:56 INFO - PROCESS | 1665 | |1;audio-beat-detection;146;110;132;156;110;128;131;115;155;107 09:25:56 INFO - PROCESS | 1665 | |2;audio-dft;202;199;200;211;240;198;191;204;271;266 09:25:56 INFO - PROCESS | 1665 | |3;audio-fft;71;82;75;147;61;58;61;64;137;50 09:25:56 INFO - PROCESS | 1665 | |4;audio-oscillator;69;70;119;99;99;110;146;60;97;147 09:25:56 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;124;87;92;86;77;124;129;91;90;119 09:25:56 INFO - PROCESS | 1665 | |6;imaging-darkroom;97;98;125;130;102;146;117;103;125;90 09:25:56 INFO - PROCESS | 1665 | |7;imaging-desaturate;77;126;80;76;84;138;150;129;91;142 09:25:56 INFO - PROCESS | 1665 | |8;json-parse-financial;55;55;56;57;55;58;57;58;78;77 09:25:56 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;63;103;81;76;71;79;78;73;69;71 09:25:56 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;84;85;86;87;85;81;77;72;89;94 09:25:56 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;146;128;149;152;147;142;154;147;197;154 09:25:56 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;167;166;162;166;171;165;163;167;165;161 09:25:56 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;69;67;69;65;65;65;67;67;72;81 09:25:56 INFO - PROCESS | 1665 | __end_tp_report 09:25:56 INFO - PROCESS | 1665 | __start_cc_report 09:25:56 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1132 09:25:56 INFO - PROCESS | 1665 | __end_cc_report 09:25:56 INFO - PROCESS | 1665 | __startTimestamp1468859156176__endTimestamp 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | ------- Summary: start ------- 09:25:56 INFO - PROCESS | 1665 | Number of tests: 14 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:120.40 Median:117.00 stddev:16.76 (14.3%) stddev-sans-first:16.95 09:25:56 INFO - PROCESS | 1665 | Values: 106.0 167.0 115.0 117.0 118.0 119.0 114.0 116.0 115.0 117.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:131.50 stddev:18.59 (14.1%) stddev-sans-first:18.67 09:25:56 INFO - PROCESS | 1665 | Values: 146.0 110.0 132.0 156.0 110.0 128.0 131.0 115.0 155.0 107.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:218.20 Median:207.50 stddev:29.65 (14.3%) stddev-sans-first:30.86 09:25:56 INFO - PROCESS | 1665 | Values: 202.0 199.0 200.0 211.0 240.0 198.0 191.0 204.0 271.0 266.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:80.60 Median:62.50 stddev:33.68 (53.9%) stddev-sans-first:35.54 09:25:56 INFO - PROCESS | 1665 | Values: 71.0 82.0 75.0 147.0 61.0 58.0 61.0 64.0 137.0 50.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:69.50 stddev:30.24 (43.5%) stddev-sans-first:29.69 09:25:56 INFO - PROCESS | 1665 | Values: 69.0 70.0 119.0 99.0 99.0 110.0 146.0 60.0 97.0 147.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:101.90 Median:86.50 stddev:19.60 (22.7%) stddev-sans-first:19.09 09:25:56 INFO - PROCESS | 1665 | Values: 124.0 87.0 92.0 86.0 77.0 124.0 129.0 91.0 90.0 119.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:113.30 Median:138.00 stddev:17.99 (13.0%) stddev-sans-first:18.09 09:25:56 INFO - PROCESS | 1665 | Values: 97.0 98.0 125.0 130.0 102.0 146.0 117.0 103.0 125.0 90.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:109.30 Median:76.50 stddev:30.19 (39.5%) stddev-sans-first:29.67 09:25:56 INFO - PROCESS | 1665 | Values: 77.0 126.0 80.0 76.0 84.0 138.0 150.0 129.0 91.0 142.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:57.50 stddev:8.98 (15.6%) stddev-sans-first:9.30 09:25:56 INFO - PROCESS | 1665 | Values: 55.0 55.0 56.0 57.0 55.0 58.0 57.0 58.0 78.0 77.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:76.40 Median:74.50 stddev:10.76 (14.4%) stddev-sans-first:10.26 09:25:56 INFO - PROCESS | 1665 | Values: 63.0 103.0 81.0 76.0 71.0 79.0 78.0 73.0 69.0 71.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:85.50 stddev:6.16 (7.2%) stddev-sans-first:6.54 09:25:56 INFO - PROCESS | 1665 | Values: 84.0 85.0 86.0 87.0 85.0 81.0 77.0 72.0 89.0 94.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:151.60 Median:150.50 stddev:17.65 (11.7%) stddev-sans-first:18.60 09:25:56 INFO - PROCESS | 1665 | Values: 146.0 128.0 149.0 152.0 147.0 142.0 154.0 147.0 197.0 154.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.30 Median:166.00 stddev:2.87 (1.7%) stddev-sans-first:2.98 09:25:56 INFO - PROCESS | 1665 | Values: 167.0 166.0 162.0 166.0 171.0 165.0 163.0 167.0 165.0 161.0 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:4.85 (7.1%) stddev-sans-first:5.15 09:25:56 INFO - PROCESS | 1665 | Values: 69.0 67.0 69.0 65.0 65.0 65.0 67.0 67.0 72.0 81.0 09:25:56 INFO - PROCESS | 1665 | -------- Summary: end -------- 09:25:56 INFO - PROCESS | 1665 | 09:25:56 INFO - TEST-INFO | 1665: exit 0 09:25:56 INFO - TEST-OK | kraken | took 60680ms 09:25:56 INFO - SUITE-END | took 1173s 09:25:57 INFO - Completed test suite (00:19:34) 09:25:57 INFO - javascript benchmark 09:25:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7408.765206218317, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3476.391631464494, 3480.4779283107546, 3498.0, 3500.2999400119984, 3504.386732321843, 5935.406459354068, 5949.494292985096, 5953.166556682063, 6034.758609655609, 6058.121572372014, 5836.037053886114, 5926.970365148169, 5992.430719081691, 5994.220751302325, 6079.05774604937, 4570.245909424958, 5334.093204155303, 5365.222042803791, 5431.456854314557, 5497.39528651848, 444.5949420270769, 5320.840374788762, 5362.892742145154, 5438.782448702047, 5440.211169380437, 5404.864878378033, 5406.54044406224, 5416.404195538487, 5416.756245968941, 5433.972830135864, 5399.649022813504, 5449.100898351767, 5450.182472629098, 5450.264214331054, 5553.416891226444, 5252.448492908228, 5304.496072873109, 5330.38700549434, 5336.573074154097, 5394.838154855361, 5767.221425107598, 5914.231149950522, 5944.613600115978, 6005.6997150142315, 6011.248593925759, 6164.106204600308, 6199.50403967686, 6246.875062498724, 6261.624302541816, 6273.96863015682, 6265.122882796412, 6304.0, 6338.556301058928, 6381.904271435932, 6381.968090159566, 6063.060225665029, 6111.266648002268, 6122.693865306762, 6124.663143527059, 6141.692915354214, 6257.405546473078, 6415.26224484181, 6545.639989800511, 6565.606063636197, 6579.111819904348, 6185.8144255672405, 6194.163787888578, 6221.097940798559, 6247.718852651642, 6259.624422534663, 6282.151909492251, 6358.745650173942, 6362.840928976812, 6397.52018598607, 6398.936010639927, 6161.568690191643, 6168.167297414881, 6205.162303089115, 6231.065340199007, 6286.182796236551, 6227.470664993526, 6236.376362363727, 6255.311915689271, 6264.843378915563, 6272.435480806749, 3986.940195897064, 5073.847784566469, 5074.619403544749, 5079.644424890296, 5083.212102124176, 4399.318105693623, 4480.462344518679, 4481.910361792811, 4502.932456013163, 4527.705699129546, 6026.819195424145, 6036.879262414727, 6088.939110608926, 6094.8943112006145, 6127.601705889103, 6325.367463253638, 6417.26201486835, 6417.326180750954, 6420.0, 6424.068510066014, 5905.911411328833, 6031.788887388921, 6105.50568046402, 6109.389061093944, 6139.907901381483, 5637.126245431965, 5640.605157639008, 5648.4633959773755, 5650.5479561634975, 5652.265205523256, 5537.501624853782, 6312.747490100344, 6600.5049621278595, 6608.107905432705, 6615.17310336208, 6272.749090036347, 6299.559030867796, 6334.809955701337, 6363.745450182126, 6397.584157029778, 6583.736650533925, 6587.934120658923, 6593.670316484061, 6602.867942641216, 6617.272100069084, 6181.041938499539, 6197.163382943425, 6278.623282603058, 6282.623042617275, 6299.275583307978, 6194.783182588588, 6284.308726040041, 6347.841303967438, 6351.2696039956, 6355.237371515448, 5158.38099428071, 6141.709538774048, 6205.720742566686, 6208.9689551551955, 6217.658028808459, 5152.458991805806, 6172.105044768573, 6178.969105154445, 6217.751289948352, 6249.78125765596, 5678.432156784289, 6151.477124444294, 6210.5652604317265, 6227.532935029801, 6232.439080482778, 6194.086013466726, 6200.472959798468, 6214.067889816563, 6219.284782250099, 6234.2830574482705, 6099.573029887865, 6107.249501910372, 6119.593952096866, 6127.708789263955, 6208.441240288395], "value": 5806.74570563938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.84868841970575, 486.6252985201397, 508.7710530261383, 539.8029719152511, 569.0724119684913, 38413.61586384139, 40924.79537602312, 40996.38505422417, 41041.97395065125, 41302.0, 41651.0, 41828.58171418285, 42276.788616056954, 42392.78803605978, 42622.57377426225, 9453.574589143487, 9659.951700241489, 9680.499522574013, 9681.806363872718, 9693.3699309545, 9676.467794271312, 9693.75765605862, 9705.41767493949, 9714.36856604322, 9747.512624368788, 9753.902460975405, 9778.413295202276, 9807.362521436084, 9831.0, 9838.606455741761, 9705.320627556073, 9724.61101555944, 9737.853932191023, 9741.074597913257, 9753.756156096084, 9684.854727179098, 9721.368111072828, 9742.464164470952, 9761.974992625743, 9769.023097690175, 39346.21307573833, 39612.00969975745, 39838.203235935405, 40142.0, 40178.0, 3010.834404107773, 3104.0, 3204.3110731192905, 3498.982505087484, 3571.6785489305826, 29512.704872951424, 29726.171015169555, 30403.935862244714, 31102.844485777652, 31756.20609484758, 2553.489302139561, 3173.809571425699, 3193.552902593639, 3218.6781321867625, 3294.3246634439884, 382368.0881595602, 441245.7937710323, 442810.0, 442906.0, 448715.0, 33171.170720731694, 33322.166945826066, 33360.666393335756, 33481.497777533354, 33504.66495335064, 34971.65028349735, 35089.1227719309, 35400.64599354025, 35719.4642080369, 35912.0, 16439.83560164407, 16719.247633856507, 16737.581560461087, 16892.662146756997, 16896.239669214916, 12574.622761317176, 12787.10490265691, 12852.807207891889, 12891.484340626457, 12916.935415322863, 19728.90135549313, 19815.009249537467, 19888.602227955358, 19931.0, 20244.0, 6876.69054892531, 8282.544460054754, 8288.50268983863, 8302.916970830214, 8377.329813614897, 886.3573908915985, 994.4629899854142, 1029.984550231747, 1062.6068354708807, 1064.11678307005, 30594.0, 30941.535876961865, 31062.038916670615, 31080.844595776878, 31097.53353699696, 886.6586364249811, 970.5341436110565, 1017.9796404071877, 1091.8034753744403, 1137.3403426012892, 15986.840131598768, 16025.679486410207, 16148.27332770028, 16169.434069807501, 16420.425285114965, 643693.0, 648560.0, 658919.0, 661981.0, 663132.0, 59308.40691593029, 59834.10248846271, 59891.0, 59997.80004399975, 60072.69963650241, 1320.8084827700122, 1359.306753555674, 1360.7618666733283, 1371.8696723811222, 1381.979270310946, 30080.3983920316, 30284.0, 30553.388932220787, 30749.0, 31156.22109447282, 50832.74583627058, 50870.23694644509, 51061.404473597555, 51120.48879511306, 51399.743001284754, 595841.0, 619905.0, 622430.0, 623734.8813255904, 625237.0, 26884.0, 26940.865295673397, 27038.594421083308, 27176.320591985357, 27311.180664580093, 47962.520374797205, 48497.7875553114, 49144.52566423013, 49312.0, 49450.75274623604, 39361.40957885691, 40377.1924561513, 40610.78167654975, 41495.377569335884, 41952.0, 40228.396574052, 40449.595504044584, 40617.796911015255, 41076.178476430905, 41319.58680413278, 33278.334433311684, 38512.844614661604, 38523.80738096291, 38993.610063898996, 39249.21501569895, 29971.0, 30446.84776576103, 32905.835470822494, 35271.294574108884, 35420.0, 23369.948352324525, 23673.40816479602, 25850.0, 26080.8695956519, 26696.19911402661], "value": 19540.510170644695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.70071344351396, 385.7280617164899, 390.69068177996706, 391.1102242398543, 410.32296710427806, 15012.324445399956, 20456.18175272989, 20831.0, 21740.130394784228, 21836.672449913265, 20585.588288234227, 20721.274755383565, 20798.272060477888, 21222.89388553055, 21223.0, 5882.9998900186965, 6106.114613381057, 6106.267247930255, 6121.632702037892, 6121.816345509642, 5939.584229103964, 5997.820065398045, 6061.66660833654, 6071.0589858571775, 6128.693565321716, 5878.088896221093, 5983.760649574012, 6040.0939859021055, 6050.394960503936, 6062.727177277033, 5929.466348028676, 5998.910016349736, 6037.698115094272, 6075.908861367083, 6079.20970273866, 5269.394019687708, 5274.736263186825, 5291.920621190685, 5292.867678308035, 5295.4704529547125, 24485.63271550928, 25665.230043098738, 25885.35286617831, 26012.219633411027, 26290.73709262902, 2323.3262353917344, 2341.4029422497324, 2495.1516484395393, 2550.196688043279, 3047.0, 9711.125998660154, 10357.741056473573, 15110.320035598425, 15623.609409764733, 16038.839611603968, 1629.4541328654914, 1660.9750853737203, 1911.2832687742098, 1917.5685470768965, 1975.1309423853459, 107053.0, 124169.0, 128643.35678321548, 131248.6875131246, 131352.0, 9509.857352139723, 11672.949434550932, 11687.123465739933, 11702.824457633142, 11732.70668233301, 12789.296588687526, 14656.706865862623, 14708.235011798439, 14744.705105897821, 14801.629959251104, 8145.226203510775, 8217.178282171735, 8325.916740832514, 8398.454100483448, 8459.957700211582, 6674.632895190714, 8050.27547520726, 8152.307053900485, 8235.95882020598, 8257.917420825836, 3990.20195960809, 4449.243628583149, 4506.504284528699, 4542.863714088517, 4580.152671755736, 1619.4574817436292, 1969.8030196980474, 1971.5662554238045, 1988.413418041681, 2013.3959812056617, 932.7201839448138, 947.9715608531617, 954.8901876284177, 1002.6139936124499, 1022.8363461846069, 20814.895925520275, 21134.048967796487, 21137.260195893068, 21221.0, 21338.466538336666, 951.7620594851287, 954.2699834626517, 955.254901177083, 976.1800087926176, 1063.4948399510172, 10913.890861091446, 11254.38100904458, 11316.886831131747, 11319.603813866475, 11351.432428378548, 545795.0, 579454.0, 614222.9288853616, 627398.0, 634585.0, 79480.60259698665, 88312.55843720741, 140839.0, 141729.29135354463, 144528.0, 964.2382517810851, 1010.3432768700403, 1010.5654568535454, 1022.5756311130946, 1036.6268143468346, 18958.52603684919, 19049.809501904805, 19187.712184316966, 19406.417807465798, 19547.413577592695, 56905.0, 57792.0, 57915.0, 58478.41521584729, 59245.0, 84473.0, 84620.0, 84909.30181396462, 85429.57285213534, 86738.0, 6418.614883107029, 6933.786587347295, 8075.555844428378, 8233.711820086268, 8415.200555947175, 12575.0, 13079.738405232032, 13624.863751362756, 13763.105398149088, 13879.306034698428, 11495.597654082067, 11572.0, 11574.6527604172, 11614.361210133524, 11773.76452470963, 9677.854832177381, 11604.07167426587, 11644.88355116438, 11752.882471175179, 11785.175037747274, 11713.238639488405, 11851.466683999068, 11980.161388702707, 12006.459709313276, 12057.336846473529, 8278.71024514139, 8331.208535189147, 8383.119772424052, 8444.113368096261, 8506.362022848434, 10421.218408619232, 10430.947845260725, 11543.76912461763, 11687.88312116868, 11714.062874969812], "value": 9793.638626212076, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1460.700556385941, 1568.059164501299, 1817.145941407538, 1902.3722171683346, 1949.5028767664244, 7145.857082858346, 8072.515649061061, 8597.785055373619, 9081.682141125053, 9121.042290559495, 8720.433171843826, 8774.868376974351, 8815.603297851596, 8874.822503549925, 8895.95552022239, 2382.356763673811, 2403.2790162951133, 2413.806895448369, 2417.7703118203744, 2422.454947636785, 2393.3179043972473, 2400.147947478646, 2421.8667973261463, 2427.490227052321, 2438.902443902242, 2090.7491101067894, 2400.6279026750794, 2418.8790560471994, 2424.866632335221, 2436.1838784007377, 2244.6408574628144, 2390.151496218835, 2395.4250979764906, 2400.59189937711, 2408.0728919366084, 2230.0410823345956, 2377.869217193054, 2390.521895620883, 2404.5912194926727, 2413.1674572272536, 8892.066333035003, 9006.06369630526, 9025.23285520725, 9027.4132181408, 9058.094190580956, 5357.598180136505, 5484.91772623411, 5500.669959802384, 5502.779888804443, 5505.119180931032, 3583.7312201584723, 3707.3326801175776, 3750.0, 3765.2093060457337, 3783.39465685489, 1099.395332567085, 1100.625787232345, 1112.2214449885112, 1116.3357802107732, 1124.9212555121144, 10699.679009629723, 11194.544709187754, 11751.0, 11899.583514576949, 11912.34482103484, 4473.530279320689, 4515.0518391137575, 4684.554967278172, 4689.577937985598, 4693.7653117344, 9161.633534658538, 9238.95380523093, 9246.398984066014, 9253.537323133816, 9270.165685088374, 5303.416624171338, 5318.308619879391, 5322.973385133127, 5329.173978033411, 5331.5201631853315, 4442.489113751895, 4795.352627395257, 4968.080905032581, 4977.377827771528, 4981.701097934136, 3285.9791228394365, 3845.4808600839087, 3893.7274390792372, 3915.882523524299, 3954.387070004154, 1027.4246422003553, 1179.728662407651, 1185.4191446191305, 1186.9969875455226, 1188.3107797477442, 772.97681069568, 936.8782058332373, 944.3719926249105, 950.9381890177254, 974.0940924939874, 5410.296661434067, 5571.498565129158, 5859.560532960045, 6067.575269731076, 6187.783427580013, 422.1283050500706, 435.28178505465604, 443.1159836126947, 448.5447271019917, 453.7935239466035, 4101.892489027946, 4123.092919557693, 4166.250074986471, 4182.372644103348, 4201.68487363449, 10225.284230103822, 10923.563057477611, 11004.834927476095, 11032.779344413068, 11042.227044106836, 10301.381917084998, 10595.788084238273, 10802.08182304513, 10949.781004379867, 11072.114230861513, 8353.916460835313, 8407.495550267126, 8445.155484451629, 8445.95777021111, 8471.745847624581, 5959.851003724768, 5962.25471816023, 5967.9701601491715, 6104.572679912541, 6198.690065496798, 9976.451295178835, 10037.046480584333, 10271.075603195748, 10293.691189264335, 10321.535530901278, 10226.437545935045, 10399.58401663925, 10406.791864162826, 10408.271421000458, 10422.530986105492, 5446.673199608036, 6537.444317232898, 7114.181869085121, 7126.0, 7198.316159964795, 8499.0, 8520.14798520143, 8550.1449855014, 8598.140185981601, 8600.053994060774, 7565.773026809205, 7651.311381975649, 7658.004459420463, 7760.30157285847, 7812.257835505618, 7490.887636685563, 7597.164311925794, 7598.582077985543, 7723.034620672416, 7750.147483776667, 7114.075170227838, 7144.24985376528, 7163.892541611775, 7205.7838264852135, 7207.9639601801655, 5023.899522009612, 5111.923321150111, 5145.974270128625, 5200.167973124282, 5207.92188117171, 5176.922346164735, 5191.091558977239, 5192.169252919514, 5247.737613119405, 5329.280547126088], "value": 4535.907089616535, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.3836231630947, 309.8667572943634, 317.83631429813653, 318.7848202463338, 320.0797706593544, 5272.420033796289, 5467.726613669321, 5707.828765137047, 5818.621789583674, 5894.086416605428, 5653.293338332708, 5662.433756624336, 5665.490105890469, 5665.603407761459, 5696.800611978581, 3605.891823245307, 3662.52387189665, 4062.735922165057, 4370.082282720617, 4394.780260986954, 3469.809160496172, 3638.508801311829, 4180.6237438630515, 4300.8085718537595, 4377.6292254963655, 3311.3708395404915, 3735.234276973214, 4164.27125253081, 4189.371594260855, 4280.3151495760685, 3682.5396825396824, 4285.57144285572, 4316.223079845627, 4319.676024298159, 4340.066885619607, 3242.0, 3332.583427071616, 3574.3363052871014, 3746.2320224353944, 3750.643688849555, 4745.857624271277, 5326.520613144836, 5512.503874651261, 5535.086710692731, 5693.572982026365, 4301.634361079312, 4396.956030439686, 4656.417947756497, 4764.404449443819, 4840.233314840093, 5008.373953255843, 6021.397860213988, 6046.27444706638, 6048.6410299983045, 6086.33050364464, 3552.502649629054, 3665.9450108248398, 3700.5559332880225, 3755.361588529929, 4011.1576568920564, 6037.879242415171, 6112.297085835142, 6298.527610429191, 6306.747730090791, 6340.841478963017, 4012.3348810244006, 4019.738716983387, 4025.295573274665, 4025.376066709665, 4052.2705912935953, 3774.1130834253927, 3788.8673896413493, 4119.546849846514, 4119.938200926988, 4121.567235440296, 4104.994276402301, 4587.564181402761, 4762.380890484214, 4870.05034018363, 4886.068358984652, 4960.875978100504, 5241.633085683966, 6013.789517366871, 6022.488088512438, 6037.547183961133, 1291.9147915750814, 1367.6922692394132, 1392.958211253664, 1396.2669598460889, 1401.85981401859, 770.942179336552, 771.4869611708151, 812.3582369927691, 850.9191626795445, 862.4609618988133, 4561.29299958507, 4727.692699974491, 4732.337472753818, 4808.975955120202, 4816.759162041954, 4717.263986887597, 4832.637552183601, 5197.714125723046, 5249.42256351801, 5332.92000619991, 4160.439835061852, 4304.591063848992, 4751.548602882721, 4763.903882291781, 4770.95229047712, 2462.9753702463104, 2503.849769013865, 2625.5142798582324, 2634.841909485437, 2764.8940423830627, 4348.152110338454, 4442.68901176921, 5122.641415100981, 5150.793968241303, 5400.864978375494, 5039.4708555601865, 5157.4584668610005, 5319.5744340452675, 5405.621606487587, 5406.702631355313, 4812.470628230962, 5381.112116500812, 5394.217838413408, 5437.972810136003, 5443.455654434604, 4786.181251124551, 5170.716594962151, 5221.895562088661, 5237.738113094406, 5297.642549065783, 4341.305391137403, 4856.902861942812, 5093.719845408538, 5102.897942041064, 5166.509181627739, 4645.465771436328, 5280.0463828383745, 5739.483446489836, 5912.782706485068, 6224.284207316216, 3409.573803274591, 3561.3767590672046, 3575.8021062944204, 3789.6020917803235, 4033.2135233630333, 5349.866253343542, 5683.2895888014, 5729.054705973468, 5948.21867658876, 6190.81427557174, 4826.734529600905, 5776.0, 5983.640981541122, 6015.819525414245, 6053.061775424816, 5405.0, 5583.855309661591, 5985.4912332450485, 6023.5181185505935, 6031.7587296507645, 5611.915821262603, 5833.941660583339, 5891.469767720926, 5898.262717160355, 5898.469137777621, 5916.674582897982, 5969.91045134332, 5974.074018527135, 5989.970050149721, 6044.0, 4868.902621947612, 5182.689038657692, 5866.002779527405, 5881.353051164283, 5929.644221346733], "value": 4094.421890851174, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.4977791989129, 716.1942814333871, 741.077358688433, 792.7106606088776, 848.5417874347852, 15502.922485387571, 15600.609984750387, 16169.19154042296, 16181.352745890179, 16189.919050404746, 14738.336774845131, 14884.479043233488, 14896.776548351756, 14917.92541037296, 14926.925365373158, 612.2285919741136, 746.940244780419, 877.4165180155189, 890.4167770110588, 902.0573500691793, 901.5041727050129, 901.9503927283997, 904.2901322461836, 907.4645958884257, 909.4497828813571, 956.1681337236614, 961.6634178037701, 962.1869520255408, 962.6534447598859, 964.2141654551554, 919.6689191890981, 949.4018768176074, 955.1546881010287, 955.3408148377632, 956.9617215311379, 705.3264132753209, 708.6563016936782, 710.1655554723179, 710.2790667472519, 712.1240873725346, 13391.263480508567, 13986.230757308344, 14811.111333319928, 14875.330610122463, 14963.625909352353, 12398.876011239952, 13248.873845723125, 14278.928605356907, 15159.696806063926, 15322.23388830565, 11957.0, 11985.520579176822, 12046.0, 12102.273863568214, 12236.388180590935, 3331.200511877132, 3502.0019294500944, 3813.31360355136, 3948.5261768587666, 3952.920941581181, 114573.68836804644, 115495.0, 116524.0, 118141.0, 119111.0, 11589.942050289694, 11654.650360489199, 11735.0, 11759.941200294115, 12075.51697932073, 24363.512729745307, 24388.390290242885, 24402.26793196207, 24403.023879044995, 24440.511189776462, 8283.95858020706, 8354.143924553497, 8413.0, 8431.15688431152, 8465.89943307366, 4515.14212299662, 4555.339475775994, 4582.862514124582, 4599.356090147382, 4607.170709272363, 3639.7998110103667, 3738.065483629093, 3750.83121259544, 3753.5683396409763, 3762.3792074307435, 666.7599664120912, 669.1234482827414, 679.6160169504215, 681.877262092828, 683.9452843772486, 620.6648409858716, 673.7406098651957, 676.7631329034798, 689.941354984832, 690.4821383962028, 9185.311101667401, 9656.082672146134, 9807.313488055768, 9847.310688251897, 9976.950115249378, 622.3496446213718, 649.909012738217, 679.5141473846223, 682.068975847964, 718.5544962123413, 4099.221147981874, 4154.563770804082, 4408.404865343137, 4549.727016379028, 4645.0, 141939.29030354987, 146339.0, 148319.0, 151019.0, 155251.0, 131360.0, 131539.3961211353, 133847.0, 134850.0, 137802.0, 74636.62681686557, 75446.24553754502, 75835.0, 106428.0, 119498.99999999827, 6958.617276049866, 8753.91246087531, 8830.470171789713, 8838.558072096497, 8908.198262156437, 42329.57670423256, 60060.79878402495, 64752.0, 65840.68318633696, 67498.98751518632, 83832.0, 97243.0, 98978.01021989688, 99476.0, 99590.0, 11466.541338346373, 13557.389917453542, 13702.314884255948, 13789.586312410644, 14213.289335532974, 15163.924180379468, 15216.239188040332, 15439.0, 15625.374985000473, 15740.68518629644, 14110.576682699535, 14327.928360358132, 14331.85668143347, 14619.269036548343, 14773.630659233606, 14302.856971430152, 14594.416223350947, 14765.852341476448, 14809.777853331992, 14811.92594037066, 13952.720945580828, 14081.0, 14241.928790355982, 14439.422423102958, 14490.203038832966, 11422.428878555873, 11431.594075611894, 11796.52813887435, 11876.940615296868, 11926.642200733992, 10752.193585481276, 10923.508442120283, 11502.654920352403, 11861.881381186078, 11884.405779711153], "value": 8012.348202988197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 167.0, 115.0, 117.0, 118.0, 119.0, 114.0, 116.0, 115.0, 117.0], "value": 120.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 110.0, 132.0, 156.0, 110.0, 128.0, 131.0, 115.0, 155.0, 107.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 199.0, 200.0, 211.0, 240.0, 198.0, 191.0, 204.0, 271.0, 266.0], "value": 218.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 82.0, 75.0, 147.0, 61.0, 58.0, 61.0, 64.0, 137.0, 50.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 119.0, 99.0, 99.0, 110.0, 146.0, 60.0, 97.0, 147.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 87.0, 92.0, 86.0, 77.0, 124.0, 129.0, 91.0, 90.0, 119.0], "value": 101.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 125.0, 130.0, 102.0, 146.0, 117.0, 103.0, 125.0, 90.0], "value": 113.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 126.0, 80.0, 76.0, 84.0, 138.0, 150.0, 129.0, 91.0, 142.0], "value": 109.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 57.0, 55.0, 58.0, 57.0, 58.0, 78.0, 77.0], "value": 60.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 103.0, 81.0, 76.0, 71.0, 79.0, 78.0, 73.0, 69.0, 71.0], "value": 76.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 86.0, 87.0, 85.0, 81.0, 77.0, 72.0, 89.0, 94.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 149.0, 152.0, 147.0, 142.0, 154.0, 147.0, 197.0, 154.0], "value": 151.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 162.0, 166.0, 171.0, 165.0, 163.0, 167.0, 165.0, 161.0], "value": 165.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 65.0, 65.0, 65.0, 67.0, 67.0, 72.0, 81.0], "value": 68.7, "unit": "score"}]}]} 09:25:57 INFO - Return code: 0 09:25:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:57 ERROR - # TBPL SUCCESS # 09:25:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:25:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:25:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:25:57 INFO - 2016-07-18 09:25:57.457 screenresolution[1670:11621] starting screenresolution argv=screenresolution get 09:25:57 INFO - 2016-07-18 09:25:57.459 screenresolution[1670:11621] Display 0: 1600x1200x32@60 09:25:57 INFO - 2016-07-18 09:25:57.465 screenresolution[1671:11624] starting screenresolution argv=screenresolution list 09:25:57 INFO - Available Modes on Display 0 09:25:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:25:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:25:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:25:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:25:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:25:57 INFO - Intel Iris: 09:25:57 INFO - Chipset Model: Intel Iris 09:25:57 INFO - Type: GPU 09:25:57 INFO - Bus: Built-In 09:25:57 INFO - VRAM (Dynamic, Max): 1536 MB 09:25:57 INFO - Vendor: Intel (0x8086) 09:25:57 INFO - Device ID: 0x0a2e 09:25:57 INFO - Revision ID: 0x0009 09:25:57 INFO - Displays: 09:25:57 INFO - Display: 09:25:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:25:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:25:57 INFO - Display Serial Number: 1600x1200 60 09:25:57 INFO - Main Display: Yes 09:25:57 INFO - Mirror: Off 09:25:57 INFO - Online: Yes 09:25:57 INFO - Rotation: Supported 09:25:57 INFO - Return code: 0 09:25:57 INFO - Running post-action listener: _resource_record_post_action 09:25:57 INFO - ##### 09:25:57 INFO - ##### Finished run-tests step (success) 09:25:57 INFO - ##### 09:25:57 INFO - Running post-run listener: _resource_record_post_run 09:25:57 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 31698432; Write bytes: 707678208; Read time: 202; Write time: 1964 09:25:57 INFO - TinderboxPrint: CPU usage
54.5% 09:25:57 INFO - TinderboxPrint: I/O read bytes / time
31,698,432 / 202 09:25:57 INFO - TinderboxPrint: I/O write bytes / time
707,678,208 / 1,964 09:25:57 INFO - TinderboxPrint: CPU idle
2,202.9 (45.5%) 09:25:57 INFO - TinderboxPrint: CPU system
975.6 (20.2%) 09:25:57 INFO - TinderboxPrint: CPU user
1,659.2 (34.3%) 09:25:57 INFO - TinderboxPrint: Swap in / out
435,585,024 / 0 09:25:57 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 405176832; Write bytes: 401057792; Read time: 30823; Write time: 830 09:25:57 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29609472; Write bytes: 294942720; Read time: 183; Write time: 1099 09:25:58 INFO - Running post-run listener: _upload_blobber_files 09:25:58 INFO - Blob upload gear active. 09:25:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:58 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 09:25:58 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'] 09:25:58 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 09:25:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:25:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:25:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:59 INFO - (blobuploader) - INFO - Done attempting. 09:25:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:25:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:26:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:00 INFO - (blobuploader) - INFO - Done attempting. 09:26:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:03 INFO - (blobuploader) - INFO - Done attempting. 09:26:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:03 INFO - Return code: 0 09:26:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e48127d99caadfde64ef4296f2e589d239e02571b9044eaa3e93cb7062de8438013c94c2830ac4380349940698c5dd4913ac5cef18a4fb0383efa04822359a03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98ccc16243640c37148412e22085faf405381718a69047e0563f4c81885a992922095c1a8ce8f71d9300d7d22b002e3841fda11fd2b3fc8382c93a6be0e0c02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4e23505804b3ce163a621914ee28535845b2115b072d30b357e62dc92f26fd0922aa4e202f7005c753e889a50b4da532065fcc9556bce9cf591fc2f54e89ce2"} 09:26:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:03 INFO - Contents: 09:26:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e48127d99caadfde64ef4296f2e589d239e02571b9044eaa3e93cb7062de8438013c94c2830ac4380349940698c5dd4913ac5cef18a4fb0383efa04822359a03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98ccc16243640c37148412e22085faf405381718a69047e0563f4c81885a992922095c1a8ce8f71d9300d7d22b002e3841fda11fd2b3fc8382c93a6be0e0c02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4e23505804b3ce163a621914ee28535845b2115b072d30b357e62dc92f26fd0922aa4e202f7005c753e889a50b4da532065fcc9556bce9cf591fc2f54e89ce2"} 09:26:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:03 INFO - Copying logs to upload dir... 09:26:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.921957 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-07-18 09:26:03.976213) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 09:26:03.979376) ========= 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.GthjlbxKje/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.kCiU9WwSVo/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e48127d99caadfde64ef4296f2e589d239e02571b9044eaa3e93cb7062de8438013c94c2830ac4380349940698c5dd4913ac5cef18a4fb0383efa04822359a03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98ccc16243640c37148412e22085faf405381718a69047e0563f4c81885a992922095c1a8ce8f71d9300d7d22b002e3841fda11fd2b3fc8382c93a6be0e0c02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4e23505804b3ce163a621914ee28535845b2115b072d30b357e62dc92f26fd0922aa4e202f7005c753e889a50b4da532065fcc9556bce9cf591fc2f54e89ce2"} build_url:https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011116 build_url: 'https://queue.taskcluster.net/v1/task/A0kSV0ekShiGxrq3BId_LQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e48127d99caadfde64ef4296f2e589d239e02571b9044eaa3e93cb7062de8438013c94c2830ac4380349940698c5dd4913ac5cef18a4fb0383efa04822359a03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98ccc16243640c37148412e22085faf405381718a69047e0563f4c81885a992922095c1a8ce8f71d9300d7d22b002e3841fda11fd2b3fc8382c93a6be0e0c02f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d4e23505804b3ce163a621914ee28535845b2115b072d30b357e62dc92f26fd0922aa4e202f7005c753e889a50b4da532065fcc9556bce9cf591fc2f54e89ce2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 09:26:04.014067) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:26:04.014445) ========= 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.GthjlbxKje/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.kCiU9WwSVo/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 09:26:04.064023) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 09:26:04.064431) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 09:26:04.064823) ========= ========= Total master_lag: 0.17 =========