builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0345 starttime: 1473289196.13 results: success (0) buildid: 20160907134815 builduid: af232e86bdfb47ea85f1f5d35be871d6 revision: 054d2453311b5adf511c5cfaa59e27db955405f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.133531) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.134009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.134289) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.160702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.161100) ========= 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.eW74AECKul/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.MiRzlvjVOh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-07 15:59:56-- 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% 18.7M=0.001s 2016-09-07 15:59:56 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097779 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.281208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.281540) ========= 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.eW74AECKul/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.MiRzlvjVOh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.026243 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 15:59:56.330376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 12 mins, 32 secs) (at 2016-09-07 15:59:56.330743) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 054d2453311b5adf511c5cfaa59e27db955405f7 --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 054d2453311b5adf511c5cfaa59e27db955405f7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eW74AECKul/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.MiRzlvjVOh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-07 15:59:56,406 truncating revision to first 12 chars 2016-09-07 15:59:56,407 Setting DEBUG logging. 2016-09-07 15:59:56,407 attempt 1/10 2016-09-07 15:59:56,407 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:00:56,816 sleeping for 10.00s (attempt 1/10) 2016-09-07 16:01:06,817 attempt 2/10 2016-09-07 16:01:06,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:02:06,824 sleeping for 15.00s (attempt 2/10) 2016-09-07 16:02:21,825 attempt 3/10 2016-09-07 16:02:21,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:03:21,832 sleeping for 22.50s (attempt 3/10) 2016-09-07 16:03:44,333 attempt 4/10 2016-09-07 16:03:44,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:04:44,681 sleeping for 33.75s (attempt 4/10) 2016-09-07 16:05:18,432 attempt 5/10 2016-09-07 16:05:18,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:06:18,776 sleeping for 51.62s (attempt 5/10) 2016-09-07 16:07:10,408 attempt 6/10 2016-09-07 16:07:10,409 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:08:10,751 sleeping for 77.44s (attempt 6/10) 2016-09-07 16:09:28,191 attempt 7/10 2016-09-07 16:09:28,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:10:28,199 sleeping for 100.00s (attempt 7/10) 2016-09-07 16:12:08,204 attempt 8/10 2016-09-07 16:12:08,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/054d2453311b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-07 16:12:28,223 unpacking tar archive at: fx-team-054d2453311b/testing/mozharness/ program finished with exit code 0 elapsedTime=752.088610 ========= master_lag: 0.39 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 12 mins, 32 secs) (at 2016-09-07 16:12:28.804893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 16:12:28.805293) ========= script_repo_revision: 054d2453311b5adf511c5cfaa59e27db955405f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-07 16:12:28.808886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 16:12:28.809254) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-07 16:12:28.830016) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-07 16:12:28.830423) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eW74AECKul/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.MiRzlvjVOh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:12:29 INFO - MultiFileLogger online at 20160907 16:12:29 in /builds/slave/test 16:12:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:12:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:12:29 INFO - {'append_to_log': False, 16:12:29 INFO - 'base_work_dir': '/builds/slave/test', 16:12:29 INFO - 'blob_upload_branch': 'Fx-Team', 16:12:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:12:29 INFO - 'branch': 'Fx-Team', 16:12:29 INFO - 'buildbot_json_path': 'buildprops.json', 16:12:29 INFO - 'config_files': ('talos/mac_config.py',), 16:12:29 INFO - 'default_actions': ('clobber', 16:12:29 INFO - 'read-buildbot-config', 16:12:29 INFO - 'download-and-extract', 16:12:29 INFO - 'populate-webroot', 16:12:29 INFO - 'create-virtualenv', 16:12:29 INFO - 'install', 16:12:29 INFO - 'run-tests'), 16:12:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:12:29 INFO - 'download_minidump_stackwalk': True, 16:12:29 INFO - 'download_symbols': 'ondemand', 16:12:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:12:29 INFO - 'tooltool.py': '/tools/tooltool.py', 16:12:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:12:29 INFO - '/tools/misc-python/virtualenv.py')}, 16:12:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:12:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:12:29 INFO - 'installer_path': 'installer.exe', 16:12:29 INFO - 'log_level': 'info', 16:12:29 INFO - 'log_name': 'talos', 16:12:29 INFO - 'log_to_console': True, 16:12:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:12:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:12:29 INFO - 'opt_config_files': (), 16:12:29 INFO - 'pip_index': False, 16:12:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:12:29 INFO - 'cmd': ('bash', 16:12:29 INFO - '-c', 16:12:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:12:29 INFO - 'enabled': True, 16:12:29 INFO - 'halt_on_failure': False, 16:12:29 INFO - 'name': 'check_screen_resolution'},), 16:12:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:12:29 INFO - 'cmd': ('bash', 16:12:29 INFO - '-c', 16:12:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:12:29 INFO - 'enabled': True, 16:12:29 INFO - 'halt_on_failure': False, 16:12:29 INFO - 'name': 'check_screen_resolution'},), 16:12:29 INFO - 'run_cmd_checks_enabled': True, 16:12:29 INFO - 'sps_profile': False, 16:12:29 INFO - 'sps_profile_interval': 0, 16:12:29 INFO - 'suite': 'dromaeojs', 16:12:29 INFO - 'system_bits': '32', 16:12:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:12:29 INFO - 'title': 't-yosemite-r7-0345', 16:12:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:12:29 INFO - 'use_talos_json': True, 16:12:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:12:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:12:29 INFO - 'work_dir': 'build'} 16:12:29 INFO - [mozharness: 2016-09-07 23:12:29.025395Z] Running clobber step. 16:12:29 INFO - Running pre-action listener: _resource_record_pre_action 16:12:29 INFO - Running main action method: clobber 16:12:29 INFO - rmtree: /builds/slave/test/build 16:12:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:12:31 INFO - Running post-action listener: _resource_record_post_action 16:12:31 INFO - [mozharness: 2016-09-07 23:12:31.040564Z] Finished clobber step (success) 16:12:31 INFO - [mozharness: 2016-09-07 23:12:31.040681Z] Running read-buildbot-config step. 16:12:31 INFO - Running pre-action listener: _resource_record_pre_action 16:12:31 INFO - Running main action method: read_buildbot_config 16:12:31 INFO - Using buildbot properties: 16:12:31 INFO - { 16:12:31 INFO - "project": "", 16:12:31 INFO - "product": "firefox", 16:12:31 INFO - "script_repo_revision": "production", 16:12:31 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:12:31 INFO - "repository": "", 16:12:31 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:12:31 INFO - "buildid": "20160907134815", 16:12:31 INFO - "pgo_build": "False", 16:12:31 INFO - "basedir": "/builds/slave/test", 16:12:31 INFO - "buildnumber": 147, 16:12:31 INFO - "slavename": "t-yosemite-r7-0345", 16:12:31 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 16:12:31 INFO - "platform": "yosemite_r7", 16:12:31 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:12:31 INFO - "branch": "fx-team", 16:12:31 INFO - "repo_path": "integration/fx-team", 16:12:31 INFO - "revision": "054d2453311b5adf511c5cfaa59e27db955405f7", 16:12:31 INFO - "stage_platform": "macosx64", 16:12:31 INFO - "builduid": "af232e86bdfb47ea85f1f5d35be871d6", 16:12:31 INFO - "slavebuilddir": "test" 16:12:31 INFO - } 16:12:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 16:12:31 INFO - Running post-action listener: _resource_record_post_action 16:12:31 INFO - [mozharness: 2016-09-07 23:12:31.044656Z] Finished read-buildbot-config step (success) 16:12:31 INFO - [mozharness: 2016-09-07 23:12:31.044905Z] Running download-and-extract step. 16:12:31 INFO - Running pre-action listener: _resource_record_pre_action 16:12:31 INFO - Running main action method: download_and_extract 16:12:31 INFO - mkdir: /builds/slave/test/build/tests 16:12: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:31 INFO - trying https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 16:12:31 INFO - Downloading https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:12:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 16:12:32 INFO - Downloaded 1199 bytes. 16:12:32 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 16:12:32 INFO - Using the following test package requirements: 16:12:32 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:12:32 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 16:12:32 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 16:12:32 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'jsshell-mac.zip'], 16:12:32 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 16:12:32 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 16:12:32 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 16:12:32 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 16:12:32 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 16:12:32 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 16:12:32 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 16:12:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:12:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:12:32 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 16:12:40 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:12:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 16:12:40 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 16:12:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 16:12:47 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 16:12:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:48 INFO - trying https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:12:48 INFO - Downloading https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 16:12:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 16:12:51 INFO - Downloaded 111555777 bytes. 16:12:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:12:51 INFO - mkdir: /builds/slave/test/properties 16:12:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:12:51 INFO - Writing to file /builds/slave/test/properties/build_url 16:12:51 INFO - Contents: 16:12:51 INFO - build_url:https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 16:12:52 INFO - Running post-action listener: _resource_record_post_action 16:12:52 INFO - Running post-action listener: set_extra_try_arguments 16:12:52 INFO - [mozharness: 2016-09-07 23:12:52.861422Z] Finished download-and-extract step (success) 16:12:52 INFO - [mozharness: 2016-09-07 23:12:52.861555Z] Running populate-webroot step. 16:12:52 INFO - Running pre-action listener: _resource_record_pre_action 16:12:52 INFO - Running main action method: populate_webroot 16:12:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:12:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:12:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:12:52 INFO - '--tppagecycles', 16:12:52 INFO - '7'], 16:12:52 INFO - 'tests': ['tsvgm']}}, 16:12:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:12:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:12:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:12:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:12:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:12:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['damp', 'tps']}, 16:12:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'tests': ['damp', 'tps']}, 16:12:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['dromaeo_dom']}, 16:12:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:12:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['basic_compositor_video']}, 16:12:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:12:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['a11yr', 16:12:52 INFO - 'ts_paint', 16:12:52 INFO - 'tpaint', 16:12:52 INFO - 'sessionrestore', 16:12:52 INFO - 'sessionrestore_no_auto_restore', 16:12:52 INFO - 'tabpaint']}, 16:12:52 INFO - 'other-e10s': {'tests': ['a11yr', 16:12:52 INFO - 'ts_paint', 16:12:52 INFO - 'tpaint', 16:12:52 INFO - 'sessionrestore', 16:12:52 INFO - 'sessionrestore_no_auto_restore', 16:12:52 INFO - 'tabpaint']}, 16:12:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:12:52 INFO - 'ts_paint', 16:12:52 INFO - 'tpaint', 16:12:52 INFO - 'sessionrestore', 16:12:52 INFO - 'sessionrestore_no_auto_restore', 16:12:52 INFO - 'tabpaint']}, 16:12:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:12:52 INFO - 'ts_paint', 16:12:52 INFO - 'tpaint', 16:12:52 INFO - 'sessionrestore', 16:12:52 INFO - 'sessionrestore_no_auto_restore', 16:12:52 INFO - 'tabpaint']}, 16:12:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['a11yr', 16:12:52 INFO - 'ts_paint', 16:12:52 INFO - 'tpaint', 16:12:52 INFO - 'sessionrestore', 16:12:52 INFO - 'sessionrestore_no_auto_restore', 16:12:52 INFO - 'tabpaint']}, 16:12:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['a11yr', 16:12:52 INFO - 'ts_paint', 16:12:52 INFO - 'tpaint', 16:12:52 INFO - 'sessionrestore', 16:12:52 INFO - 'sessionrestore_no_auto_restore', 16:12:52 INFO - 'tabpaint']}, 16:12:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['tsvgx', 16:12:52 INFO - 'tsvgr_opacity', 16:12:52 INFO - 'tart', 16:12:52 INFO - 'tscrollx', 16:12:52 INFO - 'cart']}, 16:12:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:12:52 INFO - 'tsvgr_opacity', 16:12:52 INFO - 'tart', 16:12:52 INFO - 'tscrollx', 16:12:52 INFO - 'cart']}, 16:12:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'talos_options': ['--disable-e10s'], 16:12:52 INFO - 'tests': ['tp5o']}, 16:12:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'tests': ['tp5o']}, 16:12:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'talos_options': ['--disable-e10s', 16:12:52 INFO - '--xperf_path', 16:12:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:52 INFO - 'tests': ['tp5n']}, 16:12:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:12:52 INFO - 'talos_options': ['--xperf_path', 16:12:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:12:52 INFO - 'tests': ['tp5n']}}, 16:12:52 INFO - 'talos.zip': {'path': '', 16:12:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:12:52 INFO - Running post-action listener: _resource_record_post_action 16:12:52 INFO - [mozharness: 2016-09-07 23:12:52.880579Z] Finished populate-webroot step (success) 16:12:52 INFO - [mozharness: 2016-09-07 23:12:52.880721Z] Running create-virtualenv step. 16:12:52 INFO - Running pre-action listener: _resource_record_pre_action 16:12:52 INFO - Running main action method: create_virtualenv 16:12:52 INFO - Creating virtualenv /builds/slave/test/build/venv 16:12:52 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 16:12:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:12:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:12:53 INFO - Using real prefix '/tools/python27' 16:12:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:12:53 INFO - Installing distribute.............................................................................................................................................................................................done. 16:12:56 INFO - Installing pip.................done. 16:12:56 INFO - Return code: 0 16:12:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:12:56 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 16:12:56 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 16:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:56 INFO - 'HOME': '/Users/cltbld', 16:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PAGER': '/bin/cat', 16:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:12:56 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - 'XPC_FLAGS': '0x0', 16:12:56 INFO - 'XPC_SERVICE_NAME': '0', 16:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:56 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 16:12:56 INFO - Cleaning up... 16:12:56 INFO - Return code: 0 16:12:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:12:56 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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:12:56 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 16:12:56 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 16:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:56 INFO - 'HOME': '/Users/cltbld', 16:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:56 INFO - 'LOGNAME': 'cltbld', 16:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:56 INFO - 'MOZ_NO_REMOTE': '1', 16:12:56 INFO - 'NO_EM_RESTART': '1', 16:12:56 INFO - 'PAGER': '/bin/cat', 16:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:56 INFO - 'PWD': '/builds/slave/test', 16:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:56 INFO - 'SHELL': '/bin/bash', 16:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:12:56 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:56 INFO - 'USER': 'cltbld', 16:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:56 INFO - 'XPC_FLAGS': '0x0', 16:12:56 INFO - 'XPC_SERVICE_NAME': '0', 16:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:12:57 INFO - Downloading/unpacking psutil>=3.1.1 16:12:57 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 16:12:57 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 16:12:57 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 16:12:57 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 16:12:57 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 16:12:57 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 16:13:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:13:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:00 INFO - Installing collected packages: psutil 16:13:00 INFO - Running setup.py install for psutil 16:13:00 INFO - building 'psutil._psutil_osx' extension 16:13:00 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 16:13:01 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 16:13:01 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 16:13:01 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 16:13:01 INFO - building 'psutil._psutil_posix' extension 16:13:01 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 16:13:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:13:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:13:01 INFO - ^ 16:13:01 INFO - 1 warning generated. 16:13:01 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 16:13:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:13:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:13:01 INFO - Successfully installed psutil 16:13:01 INFO - Cleaning up... 16:13:01 INFO - Return code: 0 16:13:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:13:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:01 INFO - 'HOME': '/Users/cltbld', 16:13:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:01 INFO - 'LOGNAME': 'cltbld', 16:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:01 INFO - 'MOZ_NO_REMOTE': '1', 16:13:01 INFO - 'NO_EM_RESTART': '1', 16:13:01 INFO - 'PAGER': '/bin/cat', 16:13:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:01 INFO - 'PWD': '/builds/slave/test', 16:13:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:01 INFO - 'SHELL': '/bin/bash', 16:13:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:01 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:01 INFO - 'USER': 'cltbld', 16:13:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:01 INFO - 'XPC_FLAGS': '0x0', 16:13:01 INFO - 'XPC_SERVICE_NAME': '0', 16:13:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:13:01 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 16:13:01 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 16:13:01 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 16:13:01 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 16:13:01 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 16:13:01 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 16:13:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:13:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:13:04 INFO - Installing collected packages: mozsystemmonitor 16:13:04 INFO - Running setup.py install for mozsystemmonitor 16:13:04 INFO - Successfully installed mozsystemmonitor 16:13:04 INFO - Cleaning up... 16:13:04 INFO - Return code: 0 16:13:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:13:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:04 INFO - 'HOME': '/Users/cltbld', 16:13:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:04 INFO - 'LOGNAME': 'cltbld', 16:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:04 INFO - 'MOZ_NO_REMOTE': '1', 16:13:04 INFO - 'NO_EM_RESTART': '1', 16:13:04 INFO - 'PAGER': '/bin/cat', 16:13:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:04 INFO - 'PWD': '/builds/slave/test', 16:13:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:04 INFO - 'SHELL': '/bin/bash', 16:13:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:04 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:04 INFO - 'USER': 'cltbld', 16:13:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:04 INFO - 'XPC_FLAGS': '0x0', 16:13:04 INFO - 'XPC_SERVICE_NAME': '0', 16:13:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:04 INFO - Downloading/unpacking jsonschema==2.5.1 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:13:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:07 INFO - Downloading functools32-3.2.3-2.tar.gz 16:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:13:07 INFO - warning: no files found matching '*.txt' 16:13:07 INFO - no previously-included directories found matching 'build' 16:13:07 INFO - no previously-included directories found matching 'dist' 16:13:07 INFO - no previously-included directories found matching '.git*' 16:13:07 INFO - Installing collected packages: jsonschema, functools32 16:13:07 INFO - Running setup.py install for functools32 16:13:08 INFO - warning: no files found matching '*.txt' 16:13:08 INFO - no previously-included directories found matching 'build' 16:13:08 INFO - no previously-included directories found matching 'dist' 16:13:08 INFO - no previously-included directories found matching '.git*' 16:13:08 INFO - Successfully installed jsonschema functools32 16:13:08 INFO - Cleaning up... 16:13:08 INFO - Return code: 0 16:13:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:08 INFO - 'HOME': '/Users/cltbld', 16:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:08 INFO - 'LOGNAME': 'cltbld', 16:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:08 INFO - 'MOZ_NO_REMOTE': '1', 16:13:08 INFO - 'NO_EM_RESTART': '1', 16:13:08 INFO - 'PAGER': '/bin/cat', 16:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:08 INFO - 'PWD': '/builds/slave/test', 16:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:08 INFO - 'SHELL': '/bin/bash', 16:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:08 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:08 INFO - 'USER': 'cltbld', 16:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:08 INFO - 'XPC_FLAGS': '0x0', 16:13:08 INFO - 'XPC_SERVICE_NAME': '0', 16:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:13:08 INFO - Cleaning up... 16:13:08 INFO - Return code: 0 16:13:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:13:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:13:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:08 INFO - 'HOME': '/Users/cltbld', 16:13:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:08 INFO - 'LOGNAME': 'cltbld', 16:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:08 INFO - 'MOZ_NO_REMOTE': '1', 16:13:08 INFO - 'NO_EM_RESTART': '1', 16:13:08 INFO - 'PAGER': '/bin/cat', 16:13:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:08 INFO - 'PWD': '/builds/slave/test', 16:13:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:08 INFO - 'SHELL': '/bin/bash', 16:13:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:08 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:08 INFO - 'USER': 'cltbld', 16:13:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:08 INFO - 'XPC_FLAGS': '0x0', 16:13:08 INFO - 'XPC_SERVICE_NAME': '0', 16:13:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:08 INFO - Downloading/unpacking blobuploader==1.2.4 16:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:13:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:13:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:13:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:13:12 INFO - Downloading docopt-0.6.1.tar.gz 16:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:13:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:13:12 INFO - Running setup.py install for blobuploader 16:13:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:13:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:13:12 INFO - Running setup.py install for requests 16:13:13 INFO - Running setup.py install for docopt 16:13:13 INFO - Successfully installed blobuploader requests docopt 16:13:13 INFO - Cleaning up... 16:13:13 INFO - Return code: 0 16:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:13 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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:13 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 16:13:13 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 16:13:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:13 INFO - 'HOME': '/Users/cltbld', 16:13:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:13 INFO - 'LOGNAME': 'cltbld', 16:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:13 INFO - 'MOZ_NO_REMOTE': '1', 16:13:13 INFO - 'NO_EM_RESTART': '1', 16:13:13 INFO - 'PAGER': '/bin/cat', 16:13:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:13 INFO - 'PWD': '/builds/slave/test', 16:13:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:13 INFO - 'SHELL': '/bin/bash', 16:13:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:13 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:13 INFO - 'USER': 'cltbld', 16:13:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:13 INFO - 'XPC_FLAGS': '0x0', 16:13:13 INFO - 'XPC_SERVICE_NAME': '0', 16:13:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:13 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-duSUFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:13 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-GxZFKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:13 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-yXC1y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:13 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-llIuWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-m5jR7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-jTIvMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-MC6zqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-1KZevD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9jvvZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-9ZSW7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-1bfVAk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-MWLdj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-6V0hxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:14 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-U1nj5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-5wlYsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-sZjYXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:15 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-CWplJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:13:15 INFO - Running setup.py install for manifestparser 16:13:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:13:15 INFO - Running setup.py install for mozcrash 16:13:15 INFO - Running setup.py install for mozdebug 16:13:15 INFO - Running setup.py install for mozdevice 16:13:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:13:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:13:15 INFO - Running setup.py install for mozfile 16:13:16 INFO - Running setup.py install for mozhttpd 16:13:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Running setup.py install for mozinfo 16:13:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Running setup.py install for mozInstall 16:13:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Running setup.py install for mozleak 16:13:16 INFO - Running setup.py install for mozlog 16:13:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Running setup.py install for moznetwork 16:13:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:13:16 INFO - Running setup.py install for mozprocess 16:13:17 INFO - Running setup.py install for mozprofile 16:13:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Running setup.py install for mozrunner 16:13:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Running setup.py install for mozscreenshot 16:13:17 INFO - Running setup.py install for moztest 16:13:17 INFO - Running setup.py install for mozversion 16:13:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:13:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:13:17 INFO - Cleaning up... 16:13:17 INFO - Return code: 0 16:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:17 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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:17 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 16:13:17 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 16:13:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:17 INFO - 'HOME': '/Users/cltbld', 16:13:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:17 INFO - 'LOGNAME': 'cltbld', 16:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:17 INFO - 'MOZ_NO_REMOTE': '1', 16:13:17 INFO - 'NO_EM_RESTART': '1', 16:13:17 INFO - 'PAGER': '/bin/cat', 16:13:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:17 INFO - 'PWD': '/builds/slave/test', 16:13:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:17 INFO - 'SHELL': '/bin/bash', 16:13:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:17 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:17 INFO - 'USER': 'cltbld', 16:13:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:17 INFO - 'XPC_FLAGS': '0x0', 16:13:17 INFO - 'XPC_SERVICE_NAME': '0', 16:13:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-e9RDBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-49dXt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-Q5CLyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-HD9nuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-K05Pv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-OqIVZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ik9N6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:13:18 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)) 16:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:13:18 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ggmqSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-jYZkiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-edxEc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:13:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-4MqOF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-xG6B0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-SRqslM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-BS6Lmi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-oPAnwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-ha8Ar7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:13:19 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)) 16:13:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:13:19 INFO - Running setup.py (path:/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/pip-4ovCPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:13:20 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)) 16:13:20 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)) 16:13:20 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)) 16:13:20 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)) 16:13:20 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)) 16:13:20 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)) 16:13:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13: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 16:13:22 INFO - Downloading blessings-1.6.tar.gz 16:13:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:13:22 INFO - Installing collected packages: blessings 16:13:22 INFO - Running setup.py install for blessings 16:13:22 INFO - Successfully installed blessings 16:13:22 INFO - Cleaning up... 16:13:22 INFO - Return code: 0 16:13:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:13:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:23 INFO - Reading from file tmpfile_stdout 16:13:23 INFO - Current package versions: 16:13:23 INFO - blessings == 1.6 16:13:23 INFO - blobuploader == 1.2.4 16:13:23 INFO - docopt == 0.6.1 16:13:23 INFO - functools32 == 3.2.3-2 16:13:23 INFO - jsonschema == 2.5.1 16:13:23 INFO - manifestparser == 1.1 16:13:23 INFO - mozInstall == 1.12 16:13:23 INFO - mozcrash == 0.17 16:13:23 INFO - mozdebug == 0.1 16:13:23 INFO - mozdevice == 0.48 16:13:23 INFO - mozfile == 1.2 16:13:23 INFO - mozhttpd == 0.7 16:13:23 INFO - mozinfo == 0.9 16:13:23 INFO - mozleak == 0.1 16:13:23 INFO - mozlog == 3.3 16:13:23 INFO - moznetwork == 0.27 16:13:23 INFO - mozprocess == 0.23 16:13:23 INFO - mozprofile == 0.28 16:13:23 INFO - mozrunner == 6.12 16:13:23 INFO - mozscreenshot == 0.1 16:13:23 INFO - mozsystemmonitor == 0.3 16:13:23 INFO - moztest == 0.7 16:13:23 INFO - mozversion == 1.4 16:13:23 INFO - psutil == 3.1.1 16:13:23 INFO - requests == 1.2.3 16:13:23 INFO - wsgiref == 0.1.2 16:13:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:23 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 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:23 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 16:13:23 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 16:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:23 INFO - 'HOME': '/Users/cltbld', 16:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:23 INFO - 'LOGNAME': 'cltbld', 16:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:23 INFO - 'MOZ_NO_REMOTE': '1', 16:13:23 INFO - 'NO_EM_RESTART': '1', 16:13:23 INFO - 'PAGER': '/bin/cat', 16:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:23 INFO - 'PWD': '/builds/slave/test', 16:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:23 INFO - 'SHELL': '/bin/bash', 16:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:23 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:23 INFO - 'USER': 'cltbld', 16:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:23 INFO - 'XPC_FLAGS': '0x0', 16:13:23 INFO - 'XPC_SERVICE_NAME': '0', 16:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 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)) 16:13:23 INFO - Cleaning up... 16:13:23 INFO - Return code: 0 16:13:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:13:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:13:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:13:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a6c9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a75e618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96c2c9f680>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, '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.eW74AECKul/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.MiRzlvjVOh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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 16:13:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:13:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:23 INFO - 'HOME': '/Users/cltbld', 16:13:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:23 INFO - 'LOGNAME': 'cltbld', 16:13:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:23 INFO - 'MOZ_NO_REMOTE': '1', 16:13:23 INFO - 'NO_EM_RESTART': '1', 16:13:23 INFO - 'PAGER': '/bin/cat', 16:13:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:23 INFO - 'PWD': '/builds/slave/test', 16:13:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:23 INFO - 'SHELL': '/bin/bash', 16:13:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:23 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:23 INFO - 'USER': 'cltbld', 16:13:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:23 INFO - 'XPC_FLAGS': '0x0', 16:13:23 INFO - 'XPC_SERVICE_NAME': '0', 16:13:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:13:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:13:23 INFO - Cleaning up... 16:13:23 INFO - Return code: 0 16:13:23 INFO - Running post-action listener: _resource_record_post_action 16:13:23 INFO - Running post-action listener: _start_resource_monitoring 16:13:23 INFO - Starting resource monitoring. 16:13:23 INFO - [mozharness: 2016-09-07 23:13:23.698868Z] Finished create-virtualenv step (success) 16:13:23 INFO - [mozharness: 2016-09-07 23:13:23.699864Z] Running install step. 16:13:23 INFO - Running pre-action listener: _resource_record_pre_action 16:13:23 INFO - Running main action method: install 16:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:13:23 INFO - Reading from file tmpfile_stdout 16:13:23 INFO - Detecting whether we're running mozinstall >=1.0... 16:13:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:13:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:13:24 INFO - Reading from file tmpfile_stdout 16:13:24 INFO - Output received: 16:13:24 INFO - Usage: mozinstall [options] installer 16:13:24 INFO - Options: 16:13:24 INFO - -h, --help show this help message and exit 16:13:24 INFO - -d DEST, --destination=DEST 16:13:24 INFO - Directory to install application into. [default: 16:13:24 INFO - "/builds/slave/test"] 16:13:24 INFO - --app=APP Application being installed. [default: firefox] 16:13:24 INFO - mkdir: /builds/slave/test/build/application 16:13:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:13:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:13:58 INFO - Reading from file tmpfile_stdout 16:13:58 INFO - Output received: 16:13:58 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:13:58 INFO - Running post-action listener: _resource_record_post_action 16:13:58 INFO - [mozharness: 2016-09-07 23:13:58.087219Z] Finished install step (success) 16:13:58 INFO - [mozharness: 2016-09-07 23:13:58.087361Z] Running run-tests step. 16:13:58 INFO - Running pre-action listener: _resource_record_pre_action 16:13:58 INFO - Running main action method: run_tests 16:13:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:58 INFO - 2016-09-07 16:13:58.101 screenresolution[1640:8200] starting screenresolution argv=screenresolution get 16:13:58 INFO - 2016-09-07 16:13:58.103 screenresolution[1640:8200] Display 0: 1600x1200x32@60 16:13:58 INFO - 2016-09-07 16:13:58.109 screenresolution[1641:8202] starting screenresolution argv=screenresolution list 16:13:58 INFO - Available Modes on Display 0 16:13:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:58 INFO - Intel Iris: 16:13:58 INFO - Chipset Model: Intel Iris 16:13:58 INFO - Type: GPU 16:13:58 INFO - Bus: Built-In 16:13:58 INFO - VRAM (Dynamic, Max): 1536 MB 16:13:58 INFO - Vendor: Intel (0x8086) 16:13:58 INFO - Device ID: 0x0a2e 16:13:58 INFO - Revision ID: 0x0009 16:13:58 INFO - Displays: 16:13:58 INFO - Display: 16:13:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:58 INFO - Display Serial Number: 1600x1200 60 16:13:58 INFO - Main Display: Yes 16:13:58 INFO - Mirror: Off 16:13:58 INFO - Online: Yes 16:13:58 INFO - Rotation: Supported 16:13:58 INFO - Return code: 0 16:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:13:58 INFO - Python 2.7.3 16:13:58 INFO - Return code: 0 16:13:58 INFO - grabbing minidump binary from tooltool 16:13:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:13:58 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 0x10a62dd30>, '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 0x10a392db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a625b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:13:58 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 16:13:58 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 16:13:58 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 16:13:58 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:13:58 INFO - Return code: 0 16:13:58 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:13:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:13:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:13:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:13:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:13:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 16:13:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0345 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 16:13:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eW74AECKul/Render', 16:13:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:13:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:13:58 INFO - 'HOME': '/Users/cltbld', 16:13:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:13:58 INFO - 'LOGNAME': 'cltbld', 16:13:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:13:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:13:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:13:58 INFO - 'MOZ_NO_REMOTE': '1', 16:13:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:13:58 INFO - 'NO_EM_RESTART': '1', 16:13:58 INFO - 'PAGER': '/bin/cat', 16:13:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:13:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:13:58 INFO - 'PWD': '/builds/slave/test', 16:13:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:13:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:13:58 INFO - 'SHELL': '/bin/bash', 16:13:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MiRzlvjVOh/Listeners', 16:13:58 INFO - 'TMPDIR': '/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/', 16:13:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:13:58 INFO - 'USER': 'cltbld', 16:13:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:13:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:13:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:13:58 INFO - 'XPC_FLAGS': '0x0', 16:13:58 INFO - 'XPC_SERVICE_NAME': '0', 16:13:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:13:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0345', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 16:13:58 INFO - mozversion application_buildid: 20160907134815 16:13:58 INFO - mozversion application_changeset: 054d2453311b5adf511c5cfaa59e27db955405f7 16:13:58 INFO - mozversion application_display_name: Nightly 16:13:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:13:58 INFO - mozversion application_name: Firefox 16:13:58 INFO - mozversion application_remotingname: firefox 16:13:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:13:58 INFO - mozversion application_vendor: Mozilla 16:13:58 INFO - mozversion application_version: 51.0a1 16:13:58 INFO - mozversion platform_buildid: 20160907134815 16:13:58 INFO - mozversion platform_changeset: 054d2453311b5adf511c5cfaa59e27db955405f7 16:13:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:13:58 INFO - mozversion platform_version: 51.0a1 16:13:58 INFO - using testdate: 1473290038 16:13:58 INFO - actual date: 1473290038 16:13:58 INFO - starting webserver on 'localhost:49278' 16:13:58 INFO - SUITE-START | Running 2 tests 16:13:58 INFO - TEST-START | dromaeo_css 16:13:58 INFO - operating with platform_type : mac_ 16:13:58 INFO - Initialising browser for dromaeo_css test... 16:13:58 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpVgRHAa/profile http://localhost:49278/getInfo.html) 16:14:01 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 16:14:01 INFO - PROCESS | 1651 | colorDepth:24 16:14:01 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 16:14:01 INFO - PROCESS | 1651 | __metrics 16:14:01 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:14:01 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:14:01 INFO - TEST-INFO | 1651: exit 0 16:14:01 INFO - Browser initialized. 16:14:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:14:01 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpVgRHAa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:13 INFO - PROCESS | 1654 | RSS: Main: 232386560 16:14:13 INFO - PROCESS | 1654 | 16:15:04 INFO - PROCESS | 1654 | 1473290104839 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] 16:17:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 16:17:19 INFO - PROCESS | 1654 | RSS: Main: 375472128 16:17:19 INFO - PROCESS | 1654 | 16:20:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 16:20:22 INFO - PROCESS | 1654 | RSS: Main: 379441152 16:20:22 INFO - PROCESS | 1654 | 16:23:25 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 16:23:25 INFO - PROCESS | 1654 | RSS: Main: 360222720 16:23:25 INFO - PROCESS | 1654 | 16:26:28 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 16:26:28 INFO - PROCESS | 1654 | RSS: Main: 333885440 16:26:28 INFO - PROCESS | 1654 | 16:29:32 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 16:29:33 INFO - PROCESS | 1654 | RSS: Main: 330956800 16:29:33 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 16:32:36 INFO - PROCESS | 1654 | RSS: Main: 373506048 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | __start_tp_report 16:32:36 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 16:32:36 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 16:32:36 INFO - PROCESS | 1654 | |i|pagename|runs| 16:32:36 INFO - PROCESS | 1654 | |0;dojo.html;3326.6174389945154;3344.9331013379733;3369.865205391786;3400.744944129191;3429.434143366345;5625.493705566499;5651.745671444784;5704.77180912764;5769.884602307951;5794.5943783935145;5688.175214593882;5711.828645140642;5759.568032397566;5798.82603521895;5850.707464626773;5167.199084141964;5215.374155101393;5245.370555533342;5255.185446255837;5349.839504814842;5342.1452567589195;5346.385165705955;5366.087765079946;5366.677999320033;5400.729963501829;5154.793808247666;5173.275741396207;5184.533391994701;5274.235235890794;5291.920621190685;5209.1404918188455;5234.97382513085;5253.238280449352;5256.50063243995;5256.684598924076;5153.3558305211845;5201.063808514466;5202.115640341113;5224;5245.895082098336;5641.943580564182;5655.8586035349035;5665.433456654301;5746.770129194827;5777.913331300034;6218.502519798405;6271.655058971754;6283.214598175228;6290.056491526262;6292.182016337847;6118.357572454873;6236.875262494725;6290.182276304097;6293.30773614902;6357.046443033582;5861.17943487912;5872.559558033207;5880.529557635379;5887.293524776968;5920.407959204132;6322.272938612026;6323.336049714714;6331.2085989251345;6336.58812177207;6342.143810585512;5999;6049.879002419927;6086.391360863879;6130.233720784902;6137.785177518855;6283.560150789493;6288;6292.653904035322;6296.244450665858;6304.495640348761;6179.28938172107;6219.222597175353;6220.222472190976;6225.750969961151;6251.687415629201;6082.878342433127;6097.993831017832;6121.57491608479;6132.967444181115;6245.5628106033055;5017.54842064216;5035.571976381975;5057.494250574913;5069.923951140736;5070.062038522885;4476.7090139140855;4482.7758612069265;4483.036147228361;4499;4527.456705195332;5559.16612508127;5619.100943849046;5736.311642602831;5752.17505670289;5784.045632470679;6210.285817131088;6256.217972753406;6257.4994000480765;6331.113644089831;6348.77779277723;5697.6296540724725;5737.053386191315;5777.8555536111935;5778;5803.448672376117;5355.812546560852;5494.5054945055135;5499.890002199933;5507.779688812403;5518.19986102013;6232.626042437469;6269;6302.243730752339;6312.274088479883;6323.841903952438;6291.685415729104;6294.402031806971;6299.464545513682;6304.779332723333;6320.747170113328;5267.657602255841;6248;6286.214223222098;6308.306086330592;6325.810225693236;6047.727852246748;6107.643995706967;6122.672617327995;6125.84685382869;6176.320604733565;6280.214973128359;6290.779822706183;6308.52686048539;6318.115463835159;6331.2085989251345;5466.863328416822;5989.813717992814;6154.907676384768;6173.074038894202;6180.6909654517995;5936.584439089395;6045.063015232646;6050.969745151246;6052.515798736179;6125.693715314305;5902.203202567598;6017.518598512021;6018.578699490994;6027.20356872586;6074.757009719562;6100.993336099494;6174.073888916699;6182.350853160354;6211.503079753518;6212.844678883064;5818.534517238695;5852.7658893643775;5953.940460595339;6002.639841609517;6055 16:32:36 INFO - PROCESS | 1654 | |1;ext.html;473.9052189562086;510.8722819295176;527.9419263880974;536.7423636654403;557.8131326005788;29888;39021.41467877984;40141.799291003575;40183.59816401835;42437.57562424375;41219.79390103053;41690.58309416905;41754;41785;41785.79107104468;8693.174148455886;9647.951760241189;9801.656942007032;9814.90185098147;9822.65620703272;8704.738857834274;10340.689779306595;11888.940555297211;11920.225185362968;12135.696607584792;11971.042316614694;12022.939885300604;12026.158168928136;12031.338276394796;12048.216865903732;12049.698757531045;12111.757764844653;12147.08896832741;12158.9664878485;12159.027277817753;11834;11915;11926.555056213456;11937.985271251953;11940.940295298555;39475.802620987;39701.80149099265;39727.40408893869;39739.00652483682;39741.80129099336;3564.055525285801;3620.0587847159663;3632.473291372736;3672.467492213614;3872.6514613684903;30128.54807177894;30617;31335.529967050512;31491.685083149103;31652.683473165205;3197.876697349861;3208.9358212835614;3239.5464634951127;3286.5727455430642;3317.9668203318142;380269.19730802614;380358;380581;380935;385628.3592910172;54941;55210.723946380014;55221.44778552243;55518;55533;53972;58995.70502147462;59083.40916590865;59137.70431147817;60755;15360.769588456182;15578.84421155774;15581.14303713284;15591.610209744847;15625.296861641253;11030.669079927615;11243.494042768096;11969.88030119705;12135.635930922086;12152.756944861054;14706.264686765833;15021.399144034334;15023.624409389853;15071.21182581226;15179.924100379649;7100.396466300423;7110.64446777659;7127.7148914042855;7144.464165187528;7215.783526494213;796.665400531778;919.6459363145103;931.4923366765129;931.7624005878457;1062.4209805655937;26548.60177097345;29372.706272937423;29539.704602954123;30004.54993175104;30121.246968825955;962.3985009369144;1042.9113525350278;1054.314695447965;1059.5549869055014;1068.0494360019588;14681.265936703336;15186.899537125135;15518.284300247411;15540.222988850739;15620.687586248212;669738;674309;676271;677615;679649;56404.5898852532;56540.15189772157;56759.43240567624;56830.71584642133;56842;1205.409349418796;1327.9070465067546;1341.8658134186503;1366;1369.7876829091506;26676.99535209125;27365.04222352208;30270.394592108474;30661.386772264876;30966.380672386877;47335.76332118317;47746.80632984064;47757.283640744725;47774.76112619415;47973.760131199124;545347;546829;548015;548655;549740;23781.83817831838;25192;25949.22152335433;26706.732932670424;38085.61914380821;45748;46264;47245.29132062953;47263;47460.7626961863;37958.24083518259;38238.42642360311;38274.0431489215;39342;39498.40752388659;37900.81049594734;38368.6163138365;38806.4179037309;39353;39944.841868406664;30283;36952.81523592365;37212.44181337336;37679.62320376871;37692.86921392362;24511.877440612683;29019.85490072536;31886;34116.805911792966;34219.82890085533;22722.77277227273;23070;24232.75767242305;24900.377490562158;25438.236852894443 16:32:36 INFO - PROCESS | 1654 | |2;jquery.html;354.50369482724165;377.09873402567865;377.3208225194649;388.87167234812506;411.8640848519989;15146.924265378671;15300.15849128299;19911.502212444695;20190;20304.187832486703;20275.46556680415;20524.87113208773;20775.688364674505;20919.606882554683;21158.894205528988;5779.768809247625;5836.9124463132985;6124.816255512342;6125.632462052269;6138.386161383871;6114.633122012671;6143.44708976192;6154.046122850943;6161.661108639023;6171.105189747484;3923.313420151462;5044.369453818273;6817.5227734058635;6836.213835408942;6899.931000689979;6566.63883486408;6741.898871516931;6866.073080134192;6879.449644028491;6892.241853396123;5951.9107213391835;5960.195373624549;5974.790882319098;5975.073863551156;5992.310884248323;13385.129966552144;20094.69857952132;25129;26147.215583532525;26243.212703618923;2123.5115923337717;2321.93034208974;2344.39045848079;2782.220978126128;2979.0467050543834;9741.172000379976;9884.357516761387;10292.485375731258;10349.551062851207;10403.323783954018;1832.6059897122182;1851.0837135617821;1860.4046705054388;1872.0452569189674;1922.7115932610081;85154.14845851524;128298.35850820779;130753.34623326917;131968;133343;11006.944965275123;11493;11521.366324852046;11551.76896462066;11709.414529273672;14467.710645787025;14490.85509144916;14495.565133046026;14499.92750036264;14501;8103.878441823377;8359.164083591591;8370.79073023167;8519.574021299035;8525.872111918326;8232.753017409488;8252.422330436932;8256;8437.746867593982;8442.282405995436;4382.802773875183;4434.627474301234;4454.688171828006;4533.252013417749;4611.432113081569;1521.965063756656;1817.790954040276;1820.4708045241796;1881.7741870975572;1891;628.3841835001724;698.0147116981713;790.2887401338841;802.8394321135796;931.4923366765129;15258.389664413522;19505.758157389784;20845.68731469029;20848.791512084987;21217.681734773993;929.2333824594601;946.9337146399686;952.4333021851987;960.706984369774;1001.2440607341556;8830.851989241357;9898.96060913608;10053.145482633912;10478.580856765644;10904.836427453594;587178;588337;590800;600908;601287;131483;132879.33307560423;136165;136305.318473409;137555;993.6124911284605;1003.0922015575916;1031.29356390871;1032.9173666106694;1036.8237399642078;15070.547883563511;15265.771013435029;18947.715784263524;19009.33467328637;19147.71278430797;56907;56925.57686057882;57057.42942570521;57141.42858571527;57558;83062;85724;86346;87011;87273.56363218144;7901.249381308767;7955.761327160194;7995.760127196193;8402.537860417735;8441.198086181803;9264.53677316145;12029.338386388832;12808.74382512326;13172.341382931007;13191.868081319064;10813.837792432962;11259.268147570381;11268.098552115647;11372.31766094037;11390.601328953448;10837.945810270898;10942.234043617189;11056.170787191153;11265.436728163722;11371.943140284577;9354.391964522285;10505.369677819355;10528.315659482108;11117.22179447431;11640.592579260025;7896.447248692536;8109.75670729879;8111.716089936824;8132.6746930122135;8439.451435656663;8152.554233729976;10075.790905091437;10850.728731781453;11169.106471482424;11181.888181118085 16:32:36 INFO - PROCESS | 1654 | |3;mootools.html;1381.1989046353115;1465.6042868425525;1656.4699296225206;1832.3311991123244;1894.2233684189484;8382.538960357186;8946.597403116859;8950.820983580332;8952.507612081341;8958.955205223981;7792.805179870506;8027.719029833957;8406.327493800496;8631.65473381064;8739.781505462366;2361.0319768894756;2400.59189937711;2400.639904014403;2406.3743426709007;2407.0492155598527;2147.0982187481295;2246.2138251611887;2414.263649586875;2416.8187385946035;2431.0397393029743;2376.786089251967;2387.0929046962215;2393.7965272951733;2405.687260656121;2408.4821763320883;2360.197532838843;2376.5128148729555;2384.3800611840875;2386.7135943686694;2399.2082612737754;2326.592846251899;2351.106579499796;2376.4415362389823;2378.595638741418;2387.6418537219383;8819.647214111428;8911.242544383735;8912.153345432174;8915.063918288615;8927.151920567536;5062.367204099488;5236.188390799432;5241.947580524184;5252.422233554306;5263.6578622389425;3607.801570913599;3612.8916132516065;3682.742208045438;3683.5027271318295;3687.631236876318;1080.378782200238;1084.7233955341337;1085.4409978860892;1103.773726386089;1109.4951796932376;9709.126178643884;11632.941835290854;11637.825432618518;11646.359450230233;11653.475593598308;3746.8875933722034;4632.768361581908;4805.8558243252755;4833.540813622701;4842.394700662418;9879.456629885426;9883.209343252522;9884.65403710881;9884.80230395388;9897.109260166619;4535.750533720677;5351.81268655603;5351.973240133774;5357.678539287655;5362.517373436332;4378.912421751611;4542.909141817145;4738.810447582127;4841.12859685253;4892.559669629751;3841.250956063541;3892.1826416452295;3961.7028722845903;3991.7006224533275;3998.8400463981116;1089.7057794395469;1275.789494733377;1286.5175559165314;1289.9871001290055;1305.8432988041495;817.3216230528647;858.3776761847611;892.8526793079199;920.9401388909699;955.044955044955;5717.113847353667;5726.284214473191;5808.79669211584;5963.29592843653;5995.700214989233;384.74414514347643;437.4728452215073;437.54495324861784;450.3784777007708;453.916025535277;3573.3746594345885;3824.254270417242;3873.4577159197734;3908.4918960534947;3995.400689896481;10506.159507239403;10760.192985526117;10854.78290434187;10875.945620271848;10878.782424351468;10792.568297268179;10800.51397687106;10803.621873234399;10807.67576972692;10811.135109191246;6440.6135631862235;7955.920440795518;8164.183581641907;8265.752027439186;8266.297364724065;4931.260310953386;5603.495685388335;5733.971330143323;5776.451237132465;6002.159697642246;9798.559064841957;9825.55784989663;10022.24833137503;10034.64878729241;10174.491275436347;10068.384692618385;10162.491875406347;10230.948845256024;10298.845517317395;10319.845202321821;6820.283870193558;7013.368796808108;7207.819804504929;7374.631268436664;7480.401567874448;8141.307988820779;8392.83214335722;8396.832063358577;8405.621747021522;8409.2431681149;7328.374407183552;7501.2123727007875;7529.698812047676;7562.810929726801;7583.203763604963;7301.160366557914;7315.561066336037;7359.411247100326;7458;7556.357709594746;6850.45196384298;7020.297970202939;7024.192217894803;7031.40233080194;7036.753713619999;4900.26496025599;4930.901381972412;4995.350604421402;5057.671251368649;5068.062408454448;4954.445601223441;4955.851324460272;5146.4338922717725;5222.321098257202;5228.268042474133 16:32:36 INFO - PROCESS | 1654 | |4;prototype.html;281.84216838570404;309.3210403165052;314.763927054709;319.17174931053904;319.29117359461986;4170.562090980445;5348.304720386349;5360.410354860967;5414.43148469411;5426.321709786277;5250.396204436491;5317.494837990384;5351.277577527033;5351.805759638549;5365.195220716884;3517.5402208083615;3536;3880.0687834919627;4071.7149799514045;4125.9174816503655;3628;4077.961918370818;4118.258713431581;4122.319817230154;4124.278251306025;3779.6787273081823;4006.4775385353523;4038.899027524306;4042.2319759245797;4070.6973768394128;3190.840457977092;3657.7073834093208;3812.942805857914;4051.6961227907877;4058.5851418406;2808.1575527341715;3052.8320942348164;3500.7549471537004;3504.1590018395655;3508.0705611913345;4061.7969101544804;4198.412222288882;4673.766311684402;5141.768620412053;5169.508896654812;4232.32282834748;4254.361845723135;4310.547392523771;4637.420322459692;4671.902103005791;5023.824166154167;5407.567394608422;5594.916076258859;5600.355959064678;5641.887162256732;3611.205534782344;3905.344365831262;3906.5312162540395;3911.4523966644692;3927.3323534999117;5562.078734492174;5815.505682016991;5898.587098903078;5964.821055368346;5981.700914954235;3275.5250488679008;3841.8079096045085;3910.687145028391;3942.9211415771524;3973.8609148679657;3347.163209197701;3435.9656403435647;3773.9245215095543;4000.6399424051974;4047.5750046245307;4625.375574297427;4662.347271382009;4663;4667.299905014207;4673.509281525391;5133.897322053538;5496.230527726121;5593.328800543879;5611.438856114438;5647.576431767634;1147.1511081799408;1345.7981302804658;1370.3490841850241;1373.8214032175954;1398.9930050349683;791.7703865878946;841.5399282245422;848.8175042365921;854.9871751923727;863.4301361101643;4019.718619696652;4238.321868501087;4810.278458231293;5203.713795741195;5253.632245742761;4809.495003024702;4949.82675606352;5111.718855462911;5748.5688573357165;5780.104083867007;5035.446100928895;5254.97372513135;5269.235960785742;5275.498827611371;5286.471352864683;2531.544322022017;2615.9346016349364;2934.7212014858555;2980.910572682823;3042.893498727534;5187.9883422732955;5294;5430.972845135828;5613.663180209201;6029.57792954489;5641.956238095965;5901.704914754245;5943.257092863392;5973.850653733604;5973.880522389615;4495.561420345523;5325.414204437431;5838.854028649318;5969.149898315649;5987;4507.264703089269;5446.645968012225;5775.700467394802;5782.855428614318;5800.883982320414;5685.317761868602;5698.401667824819;5705.315362156568;5715;5725.427457254241;5730.275321041357;5889.37803250989;5947.6431414115295;5970.835687040985;6010.579259451796;3014.653314868818;3460.7231421486727;3536.2573859488766;3637.2907283080604;3926.234384295035;4778.781410740239;4816.614670826255;5037.496250375079;5653.915191272216;5751.424857514216;4741.35991641124;5302.606331947633;5408.59435542328;5627.718614069198;5655.660660360391;4292.549282325311;4596.954030459787;5563.332400112013;5625.409332020079;5664.943350566607;4636.582707556337;5359.418971403367;5390.595705322195;5459.754311056092;5549.278593782944;4802.559232230247;5124.180131178993;5267.657602255841;5460.5085542301385;5551.306086739158;4257.978710106554;4630.05537674171;4787.061240197725;5455.9454405455435;5564.221009058654 16:32:36 INFO - PROCESS | 1654 | |5;yui.html;663.6018388966621;725.2783480436966;767.5739964319804;798.6086817459445;808.454293351988;15171.772423413644;16095.678086438264;16120.113393763368;16128.516144515654;16141.515754527354;12268.32524211168;14469.131852088882;14706;14742;14761.92619036906;666.7066490744081;683.9555428897106;685.1367277230676;691.2258270736781;843.4981186194204;666.7099811581953;840.9159084091604;856.5203486047802;865.6840253307561;872.1583671756754;873.3493547307233;885.9645614175425;887.8756974023642;889.7286327670058;890.2521881619439;733.5965219129484;876.6537217798966;876.9079246679071;878.091175633223;879.683314006957;527.5146864884277;542.8045903474746;653.4249860123109;654.9880434728356;656.9146011018537;12532.937335313356;12575;14241.359138838778;14764.335604897806;14816.925915370353;14177.149371037667;14777.778333325008;14797.55607331771;14820.777688334683;14948.177850218233;11943;12020.038396928225;12044.457999390048;12236.265824050586;12334.444949977273;3789.412641040643;3834.041489627593;3845.5193100862393;3866.845326186949;3989.1024519483176;126257.36871315677;127526;129415.35292323573;130510;131721;11378.601748938747;11540.769184616262;11568.710782230512;11608.593699220486;11714.414279286002;23939.521209575712;23950.161744339213;23985;24001.27996160118;24007.879960600087;7974.282314591598;8041.075276343178;8219.424640275243;8371.158345164054;8386.916130838736;4020.5175378954127;4350.651947844165;4540.341650460665;4565.817367305337;4588.082383523309;3503.7197024238;3633.6003039665616;3636.8363423646;3644.8177591120866;3655.6709896108946;518.5333200119846;622.8380621038472;633.2685747961112;634.7556190866458;641.4355367276767;560.5711630602592;587.4037851580649;615.679846479828;663.7909058646511;664.249398180063;9124.406913550598;9387.249020078378;9516.809663806824;9607.615695372107;9673.564689588986;617.2562062714418;618.6813790897692;665.3645768291367;669.581511555278;670.8322919270182;4589.931151032737;4618.907621847611;4619.95380046202;4627.537246275346;4675.345451636774;164511;167012.1550918079;168450;169669;169993;141132.588674114;146242;147393;148292;150630;121502.78497214915;122087.3895630534;124261.37869310596;124318;127268.36365818112;8846.380753347205;9036.186743193144;9070.410423322463;9108.043655416352;9202.907970920205;57772.133417997924;68756.65621671859;68865;70541;71243.28756712367;58806.411935881806;75673.10817229393;84857.1514284874;99866;108695;11503.884961150281;13218.416647930173;13296.534621288596;13349.866501335251;13505.12216705911;14919.701605968037;15215.467458639338;15278.465253716067;15306.693866122838;15590.298436570609;13739.793903091262;14011.789823152458;14167.787483187554;14361.712765744418;14799.18604476721;12337.50649974027;13761.17432954026;13885.791713124514;14245.857541424453;14395.640108997359;12871.420786064837;12988.220706757626;13265.270410127536;13350.265735384648;13589.52436664712;11337.093032557541;11562.94218528902;11697.23967942081;11729.237599556001;11959.521619135137;10918.845473709527;11397.487113080097;11498.597549085742;11633.47649355764;11663.183577149857 16:32:36 INFO - PROCESS | 1654 | __end_tp_report 16:32:36 INFO - PROCESS | 1654 | __start_cc_report 16:32:36 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1405 16:32:36 INFO - PROCESS | 1654 | __end_cc_report 16:32:36 INFO - PROCESS | 1654 | __startTimestamp1473291156680__endTimestamp 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | ------- Summary: start ------- 16:32:36 INFO - PROCESS | 1654 | Number of tests: 6 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5766.56 Median:5989.81 stddev:626.20 (10.5%) stddev-sans-first:598.16 16:32:36 INFO - PROCESS | 1654 | Values: 3326.6 3344.9 3369.9 3400.7 3429.4 5625.5 5651.7 5704.8 5769.9 5794.6 5688.2 5711.8 5759.6 5798.8 5850.7 5167.2 5215.4 5245.4 5255.2 5349.8 5342.1 5346.4 5366.1 5366.7 5400.7 5154.8 5173.3 5184.5 5274.2 5291.9 5209.1 5235.0 5253.2 5256.5 5256.7 5153.4 5201.1 5202.1 5224.0 5245.9 5641.9 5655.9 5665.4 5746.8 5777.9 6218.5 6271.7 6283.2 6290.1 6292.2 6118.4 6236.9 6290.2 6293.3 6357.0 5861.2 5872.6 5880.5 5887.3 5920.4 6322.3 6323.3 6331.2 6336.6 6342.1 5999.0 6049.9 6086.4 6130.2 6137.8 6283.6 6288.0 6292.7 6296.2 6304.5 6179.3 6219.2 6220.2 6225.8 6251.7 6082.9 6098.0 6121.6 6133.0 6245.6 5017.5 5035.6 5057.5 5069.9 5070.1 4476.7 4482.8 4483.0 4499.0 4527.5 5559.2 5619.1 5736.3 5752.2 5784.0 6210.3 6256.2 6257.5 6331.1 6348.8 5697.6 5737.1 5777.9 5778.0 5803.4 5355.8 5494.5 5499.9 5507.8 5518.2 6232.6 6269.0 6302.2 6312.3 6323.8 6291.7 6294.4 6299.5 6304.8 6320.7 5267.7 6248.0 6286.2 6308.3 6325.8 6047.7 6107.6 6122.7 6125.8 6176.3 6280.2 6290.8 6308.5 6318.1 6331.2 5466.9 5989.8 6154.9 6173.1 6180.7 5936.6 6045.1 6051.0 6052.5 6125.7 5902.2 6017.5 6018.6 6027.2 6074.8 6101.0 6174.1 6182.4 6211.5 6212.8 5818.5 5852.8 5953.9 6002.6 6055.0 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:66860.39 Median:37446.03 stddev:146735.83 (391.9%) stddev-sans-first:147062.81 16:32:36 INFO - PROCESS | 1654 | Values: 473.9 510.9 527.9 536.7 557.8 29888.0 39021.4 40141.8 40183.6 42437.6 41219.8 41690.6 41754.0 41785.0 41785.8 8693.2 9648.0 9801.7 9814.9 9822.7 8704.7 10340.7 11888.9 11920.2 12135.7 11971.0 12022.9 12026.2 12031.3 12048.2 12049.7 12111.8 12147.1 12159.0 12159.0 11834.0 11915.0 11926.6 11938.0 11940.9 39475.8 39701.8 39727.4 39739.0 39741.8 3564.1 3620.1 3632.5 3672.5 3872.7 30128.5 30617.0 31335.5 31491.7 31652.7 3197.9 3208.9 3239.5 3286.6 3318.0 380269.2 380358.0 380581.0 380935.0 385628.4 54941.0 55210.7 55221.4 55518.0 55533.0 53972.0 58995.7 59083.4 59137.7 60755.0 15360.8 15578.8 15581.1 15591.6 15625.3 11030.7 11243.5 11969.9 12135.6 12152.8 14706.3 15021.4 15023.6 15071.2 15179.9 7100.4 7110.6 7127.7 7144.5 7215.8 796.7 919.6 931.5 931.8 1062.4 26548.6 29372.7 29539.7 30004.5 30121.2 962.4 1042.9 1054.3 1059.6 1068.0 14681.3 15186.9 15518.3 15540.2 15620.7 669738.0 674309.0 676271.0 677615.0 679649.0 56404.6 56540.2 56759.4 56830.7 56842.0 1205.4 1327.9 1341.9 1366.0 1369.8 26677.0 27365.0 30270.4 30661.4 30966.4 47335.8 47746.8 47757.3 47774.8 47973.8 545347.0 546829.0 548015.0 548655.0 549740.0 23781.8 25192.0 25949.2 26706.7 38085.6 45748.0 46264.0 47245.3 47263.0 47460.8 37958.2 38238.4 38274.0 39342.0 39498.4 37900.8 38368.6 38806.4 39353.0 39944.8 30283.0 36952.8 37212.4 37679.6 37692.9 24511.9 29019.9 31886.0 34116.8 34219.8 22722.8 23070.0 24232.8 24900.4 25438.2 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:35294.93 Median:2880.63 stddev:99629.87 (3458.6%) stddev-sans-first:99874.82 16:32:36 INFO - PROCESS | 1654 | Values: 354.5 377.1 377.3 388.9 411.9 15146.9 15300.2 19911.5 20190.0 20304.2 20275.5 20524.9 20775.7 20919.6 21158.9 5779.8 5836.9 6124.8 6125.6 6138.4 6114.6 6143.4 6154.0 6161.7 6171.1 3923.3 5044.4 6817.5 6836.2 6899.9 6566.6 6741.9 6866.1 6879.4 6892.2 5951.9 5960.2 5974.8 5975.1 5992.3 13385.1 20094.7 25129.0 26147.2 26243.2 2123.5 2321.9 2344.4 2782.2 2979.0 9741.2 9884.4 10292.5 10349.6 10403.3 1832.6 1851.1 1860.4 1872.0 1922.7 85154.1 128298.4 130753.3 131968.0 133343.0 11006.9 11493.0 11521.4 11551.8 11709.4 14467.7 14490.9 14495.6 14499.9 14501.0 8103.9 8359.2 8370.8 8519.6 8525.9 8232.8 8252.4 8256.0 8437.7 8442.3 4382.8 4434.6 4454.7 4533.3 4611.4 1522.0 1817.8 1820.5 1881.8 1891.0 628.4 698.0 790.3 802.8 931.5 15258.4 19505.8 20845.7 20848.8 21217.7 929.2 946.9 952.4 960.7 1001.2 8830.9 9899.0 10053.1 10478.6 10904.8 587178.0 588337.0 590800.0 600908.0 601287.0 131483.0 132879.3 136165.0 136305.3 137555.0 993.6 1003.1 1031.3 1032.9 1036.8 15070.5 15265.8 18947.7 19009.3 19147.7 56907.0 56925.6 57057.4 57141.4 57558.0 83062.0 85724.0 86346.0 87011.0 87273.6 7901.2 7955.8 7995.8 8402.5 8441.2 9264.5 12029.3 12808.7 13172.3 13191.9 10813.8 11259.3 11268.1 11372.3 11390.6 10837.9 10942.2 11056.2 11265.4 11371.9 9354.4 10505.4 10528.3 11117.2 11640.6 7896.4 8109.8 8111.7 8132.7 8439.5 8152.6 10075.8 10850.7 11169.1 11181.9 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5666.73 Median:4841.76 stddev:3203.38 (66.2%) stddev-sans-first:3196.18 16:32:36 INFO - PROCESS | 1654 | Values: 1381.2 1465.6 1656.5 1832.3 1894.2 8382.5 8946.6 8950.8 8952.5 8959.0 7792.8 8027.7 8406.3 8631.7 8739.8 2361.0 2400.6 2400.6 2406.4 2407.0 2147.1 2246.2 2414.3 2416.8 2431.0 2376.8 2387.1 2393.8 2405.7 2408.5 2360.2 2376.5 2384.4 2386.7 2399.2 2326.6 2351.1 2376.4 2378.6 2387.6 8819.6 8911.2 8912.2 8915.1 8927.2 5062.4 5236.2 5241.9 5252.4 5263.7 3607.8 3612.9 3682.7 3683.5 3687.6 1080.4 1084.7 1085.4 1103.8 1109.5 9709.1 11632.9 11637.8 11646.4 11653.5 3746.9 4632.8 4805.9 4833.5 4842.4 9879.5 9883.2 9884.7 9884.8 9897.1 4535.8 5351.8 5352.0 5357.7 5362.5 4378.9 4542.9 4738.8 4841.1 4892.6 3841.3 3892.2 3961.7 3991.7 3998.8 1089.7 1275.8 1286.5 1290.0 1305.8 817.3 858.4 892.9 920.9 955.0 5717.1 5726.3 5808.8 5963.3 5995.7 384.7 437.5 437.5 450.4 453.9 3573.4 3824.3 3873.5 3908.5 3995.4 10506.2 10760.2 10854.8 10875.9 10878.8 10792.6 10800.5 10803.6 10807.7 10811.1 6440.6 7955.9 8164.2 8265.8 8266.3 4931.3 5603.5 5734.0 5776.5 6002.2 9798.6 9825.6 10022.2 10034.6 10174.5 10068.4 10162.5 10230.9 10298.8 10319.8 6820.3 7013.4 7207.8 7374.6 7480.4 8141.3 8392.8 8396.8 8405.6 8409.2 7328.4 7501.2 7529.7 7562.8 7583.2 7301.2 7315.6 7359.4 7458.0 7556.4 6850.5 7020.3 7024.2 7031.4 7036.8 4900.3 4930.9 4995.4 5057.7 5068.1 4954.4 4955.9 5146.4 5222.3 5228.3 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4455.52 Median:4986.83 stddev:1398.65 (28.0%) stddev-sans-first:1367.04 16:32:36 INFO - PROCESS | 1654 | Values: 281.8 309.3 314.8 319.2 319.3 4170.6 5348.3 5360.4 5414.4 5426.3 5250.4 5317.5 5351.3 5351.8 5365.2 3517.5 3536.0 3880.1 4071.7 4125.9 3628.0 4078.0 4118.3 4122.3 4124.3 3779.7 4006.5 4038.9 4042.2 4070.7 3190.8 3657.7 3812.9 4051.7 4058.6 2808.2 3052.8 3500.8 3504.2 3508.1 4061.8 4198.4 4673.8 5141.8 5169.5 4232.3 4254.4 4310.5 4637.4 4671.9 5023.8 5407.6 5594.9 5600.4 5641.9 3611.2 3905.3 3906.5 3911.5 3927.3 5562.1 5815.5 5898.6 5964.8 5981.7 3275.5 3841.8 3910.7 3942.9 3973.9 3347.2 3436.0 3773.9 4000.6 4047.6 4625.4 4662.3 4663.0 4667.3 4673.5 5133.9 5496.2 5593.3 5611.4 5647.6 1147.2 1345.8 1370.3 1373.8 1399.0 791.8 841.5 848.8 855.0 863.4 4019.7 4238.3 4810.3 5203.7 5253.6 4809.5 4949.8 5111.7 5748.6 5780.1 5035.4 5255.0 5269.2 5275.5 5286.5 2531.5 2615.9 2934.7 2980.9 3042.9 5188.0 5294.0 5431.0 5613.7 6029.6 5642.0 5901.7 5943.3 5973.9 5973.9 4495.6 5325.4 5838.9 5969.1 5987.0 4507.3 5446.6 5775.7 5782.9 5800.9 5685.3 5698.4 5705.3 5715.0 5725.4 5730.3 5889.4 5947.6 5970.8 6010.6 3014.7 3460.7 3536.3 3637.3 3926.2 4778.8 4816.6 5037.5 5653.9 5751.4 4741.4 5302.6 5408.6 5627.7 5655.7 4292.5 4597.0 5563.3 5625.4 5664.9 4636.6 5359.4 5390.6 5459.8 5549.3 4802.6 5124.2 5267.7 5460.5 5551.3 4258.0 4630.1 4787.1 5455.9 5564.2 16:32:36 INFO - PROCESS | 1654 | 16:32:36 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:26920.24 Median:13755.80 stddev:44579.91 (324.1%) stddev-sans-first:44661.38 16:32:36 INFO - PROCESS | 1654 | Values: 663.6 725.3 767.6 798.6 808.5 15171.8 16095.7 16120.1 16128.5 16141.5 12268.3 14469.1 14706.0 14742.0 14761.9 666.7 684.0 685.1 691.2 843.5 666.7 840.9 856.5 865.7 872.2 873.3 886.0 887.9 889.7 890.3 733.6 876.7 876.9 878.1 879.7 527.5 542.8 653.4 655.0 656.9 12532.9 12575.0 14241.4 14764.3 14816.9 14177.1 14777.8 14797.6 14820.8 14948.2 11943.0 12020.0 12044.5 12236.3 12334.4 3789.4 3834.0 3845.5 3866.8 3989.1 126257.4 127526.0 129415.4 130510.0 131721.0 11378.6 11540.8 11568.7 11608.6 11714.4 23939.5 23950.2 23985.0 24001.3 24007.9 7974.3 8041.1 8219.4 8371.2 8386.9 4020.5 4350.7 4540.3 4565.8 4588.1 3503.7 3633.6 3636.8 3644.8 3655.7 518.5 622.8 633.3 634.8 641.4 560.6 587.4 615.7 663.8 664.2 9124.4 9387.2 9516.8 9607.6 9673.6 617.3 618.7 665.4 669.6 670.8 4589.9 4618.9 4620.0 4627.5 4675.3 164511.0 167012.2 168450.0 169669.0 169993.0 141132.6 146242.0 147393.0 148292.0 150630.0 121502.8 122087.4 124261.4 124318.0 127268.4 8846.4 9036.2 9070.4 9108.0 9202.9 57772.1 68756.7 68865.0 70541.0 71243.3 58806.4 75673.1 84857.2 99866.0 108695.0 11503.9 13218.4 13296.5 13349.9 13505.1 14919.7 15215.5 15278.5 15306.7 15590.3 13739.8 14011.8 14167.8 14361.7 14799.2 12337.5 13761.2 13885.8 14245.9 14395.6 12871.4 12988.2 13265.3 13350.3 13589.5 11337.1 11562.9 11697.2 11729.2 11959.5 10918.8 11397.5 11498.6 11633.5 11663.2 16:32:36 INFO - PROCESS | 1654 | -------- Summary: end -------- 16:32:36 INFO - PROCESS | 1654 | 16:32:37 INFO - TEST-INFO | 1654: exit 0 16:32:37 INFO - TEST-OK | dromaeo_css | took 1118602ms 16:32:37 INFO - TEST-START | kraken 16:32:37 INFO - operating with platform_type : mac_ 16:32:37 INFO - Initialising browser for kraken test... 16:32:37 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpfCMFSN/profile http://localhost:49278/getInfo.html) 16:32:39 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 16:32:39 INFO - PROCESS | 1662 | colorDepth:24 16:32:39 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 16:32:39 INFO - PROCESS | 1662 | __metrics 16:32:39 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:32:39 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:40 INFO - TEST-INFO | 1662: exit 0 16:32:40 INFO - Browser initialized. 16:32:40 INFO - Running cycle 1/1 for kraken test... 16:32:40 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/tmpfCMFSN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:52 INFO - PROCESS | 1663 | RSS: Main: 232120320 16:32:52 INFO - PROCESS | 1663 | 16:32:54 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 16:32:55 INFO - PROCESS | 1663 | RSS: Main: 291983360 16:32:55 INFO - PROCESS | 1663 | 16:32:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 16:32:59 INFO - PROCESS | 1663 | RSS: Main: 287506432 16:32:59 INFO - PROCESS | 1663 | 16:33:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 16:33:03 INFO - PROCESS | 1663 | RSS: Main: 379011072 16:33:03 INFO - PROCESS | 1663 | 16:33:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 16:33:05 INFO - PROCESS | 1663 | RSS: Main: 278130688 16:33:05 INFO - PROCESS | 1663 | 16:33:08 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:33:08 INFO - PROCESS | 1663 | RSS: Main: 282689536 16:33:08 INFO - PROCESS | 1663 | 16:33:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 16:33:12 INFO - PROCESS | 1663 | RSS: Main: 322084864 16:33:12 INFO - PROCESS | 1663 | 16:33:15 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 16:33:15 INFO - PROCESS | 1663 | RSS: Main: 322142208 16:33:15 INFO - PROCESS | 1663 | 16:33:18 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 16:33:19 INFO - PROCESS | 1663 | RSS: Main: 321150976 16:33:19 INFO - PROCESS | 1663 | 16:33:20 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:33:21 INFO - PROCESS | 1663 | RSS: Main: 298434560 16:33:21 INFO - PROCESS | 1663 | 16:33:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:33:23 INFO - PROCESS | 1663 | RSS: Main: 304136192 16:33:23 INFO - PROCESS | 1663 | 16:33:26 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:33:26 INFO - PROCESS | 1663 | RSS: Main: 303767552 16:33:26 INFO - PROCESS | 1663 | 16:33:29 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:33:30 INFO - PROCESS | 1663 | RSS: Main: 319475712 16:33:30 INFO - PROCESS | 1663 | 16:33:33 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:33:33 INFO - PROCESS | 1663 | RSS: Main: 315494400 16:33:33 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 16:33:35 INFO - PROCESS | 1663 | RSS: Main: 359137280 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | __start_tp_report 16:33:35 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 16:33:35 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 16:33:35 INFO - PROCESS | 1663 | |i|pagename|runs| 16:33:35 INFO - PROCESS | 1663 | |0;ai-astar;114;113;116;112;113;110;114;112;113;122 16:33:35 INFO - PROCESS | 1663 | |1;audio-beat-detection;152;145;128;161;106;129;126;107;175;136 16:33:35 INFO - PROCESS | 1663 | |2;audio-dft;188;185;203;259;192;184;185;217;181;182 16:33:35 INFO - PROCESS | 1663 | |3;audio-fft;78;75;76;150;58;58;57;67;139;57 16:33:35 INFO - PROCESS | 1663 | |4;audio-oscillator;82;84;129;70;68;79;149;98;102;119 16:33:35 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;92;114;87;83;86;84;86;83;86;84 16:33:35 INFO - PROCESS | 1663 | |6;imaging-darkroom;92;92;93;93;93;106;149;92;92;92 16:33:35 INFO - PROCESS | 1663 | |7;imaging-desaturate;87;85;83;81;87;68;127;131;106;84 16:33:35 INFO - PROCESS | 1663 | |8;json-parse-financial;55;55;56;56;56;55;54;54;54;55 16:33:35 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;69;72;78;76;73;70;71;70;71 16:33:35 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;88;85;85;86;81;103;106;85;89;90 16:33:35 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;134;161;150;136;135;139;136;136;178;139 16:33:35 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;177;232;194;167;229;178;167;167;167;168 16:33:35 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;59;87;88;67;66;66;67;69;66;66 16:33:35 INFO - PROCESS | 1663 | __end_tp_report 16:33:35 INFO - PROCESS | 1663 | __start_cc_report 16:33:35 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1960 16:33:35 INFO - PROCESS | 1663 | __end_cc_report 16:33:35 INFO - PROCESS | 1663 | __startTimestamp1473291215924__endTimestamp 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | ------- Summary: start ------- 16:33:35 INFO - PROCESS | 1663 | Number of tests: 14 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:3.25 (2.9%) stddev-sans-first:3.44 16:33:35 INFO - PROCESS | 1663 | Values: 114.0 113.0 116.0 112.0 113.0 110.0 114.0 112.0 113.0 122.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:136.50 Median:140.50 stddev:22.20 (15.8%) stddev-sans-first:22.82 16:33:35 INFO - PROCESS | 1663 | Values: 152.0 145.0 128.0 161.0 106.0 129.0 126.0 107.0 175.0 136.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:197.60 Median:190.00 stddev:24.31 (12.8%) stddev-sans-first:25.54 16:33:35 INFO - PROCESS | 1663 | Values: 188.0 185.0 203.0 259.0 192.0 184.0 185.0 217.0 181.0 182.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:81.50 Median:62.50 stddev:34.32 (54.9%) stddev-sans-first:36.37 16:33:35 INFO - PROCESS | 1663 | Values: 78.0 75.0 76.0 150.0 58.0 58.0 57.0 67.0 139.0 57.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:98.00 Median:74.50 stddev:26.91 (36.1%) stddev-sans-first:27.91 16:33:35 INFO - PROCESS | 1663 | Values: 82.0 84.0 129.0 70.0 68.0 79.0 149.0 98.0 102.0 119.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:88.50 Median:86.00 stddev:9.34 (10.9%) stddev-sans-first:9.82 16:33:35 INFO - PROCESS | 1663 | Values: 92.0 114.0 87.0 83.0 86.0 84.0 86.0 83.0 86.0 84.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:99.40 Median:92.00 stddev:17.95 (19.5%) stddev-sans-first:18.84 16:33:35 INFO - PROCESS | 1663 | Values: 92.0 92.0 93.0 93.0 93.0 106.0 149.0 92.0 92.0 92.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:83.50 stddev:20.67 (24.8%) stddev-sans-first:21.78 16:33:35 INFO - PROCESS | 1663 | Values: 87.0 85.0 83.0 81.0 87.0 68.0 127.0 131.0 106.0 84.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 16:33:35 INFO - PROCESS | 1663 | Values: 55.0 55.0 56.0 56.0 56.0 55.0 54.0 54.0 54.0 55.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.50 stddev:3.63 (5.1%) stddev-sans-first:2.99 16:33:35 INFO - PROCESS | 1663 | Values: 65.0 69.0 72.0 78.0 76.0 73.0 70.0 71.0 70.0 71.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:85.50 stddev:8.18 (9.6%) stddev-sans-first:8.65 16:33:35 INFO - PROCESS | 1663 | Values: 88.0 85.0 85.0 86.0 81.0 103.0 106.0 85.0 89.0 90.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:139.00 stddev:14.54 (10.5%) stddev-sans-first:14.93 16:33:35 INFO - PROCESS | 1663 | Values: 134.0 161.0 150.0 136.0 135.0 139.0 136.0 136.0 178.0 139.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:177.50 stddev:25.65 (14.5%) stddev-sans-first:27.06 16:33:35 INFO - PROCESS | 1663 | Values: 177.0 232.0 194.0 167.0 229.0 178.0 167.0 167.0 167.0 168.0 16:33:35 INFO - PROCESS | 1663 | 16:33:35 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:67.00 stddev:9.53 (14.2%) stddev-sans-first:9.22 16:33:35 INFO - PROCESS | 1663 | Values: 59.0 87.0 88.0 67.0 66.0 66.0 67.0 69.0 66.0 66.0 16:33:35 INFO - PROCESS | 1663 | -------- Summary: end -------- 16:33:35 INFO - PROCESS | 1663 | 16:33:36 INFO - TEST-INFO | 1663: exit 0 16:33:36 INFO - TEST-OK | kraken | took 59453ms 16:33:36 INFO - SUITE-END | took 1178s 16:33:37 INFO - Completed test suite (00:19:38) 16:33:37 INFO - javascript benchmark 16:33:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.6174389945154, 3344.9331013379733, 3369.865205391786, 3400.744944129191, 3429.434143366345, 5625.493705566499, 5651.745671444784, 5704.77180912764, 5769.884602307951, 5794.5943783935145, 5688.175214593882, 5711.828645140642, 5759.568032397566, 5798.82603521895, 5850.707464626773, 5167.199084141964, 5215.374155101393, 5245.370555533342, 5255.185446255837, 5349.839504814842, 5342.1452567589195, 5346.385165705955, 5366.087765079946, 5366.677999320033, 5400.729963501829, 5154.793808247666, 5173.275741396207, 5184.533391994701, 5274.235235890794, 5291.920621190685, 5209.1404918188455, 5234.97382513085, 5253.238280449352, 5256.50063243995, 5256.684598924076, 5153.3558305211845, 5201.063808514466, 5202.115640341113, 5224.0, 5245.895082098336, 5641.943580564182, 5655.8586035349035, 5665.433456654301, 5746.770129194827, 5777.913331300034, 6218.502519798405, 6271.655058971754, 6283.214598175228, 6290.056491526262, 6292.182016337847, 6118.357572454873, 6236.875262494725, 6290.182276304097, 6293.30773614902, 6357.046443033582, 5861.17943487912, 5872.559558033207, 5880.529557635379, 5887.293524776968, 5920.407959204132, 6322.272938612026, 6323.336049714714, 6331.2085989251345, 6336.58812177207, 6342.143810585512, 5999.0, 6049.879002419927, 6086.391360863879, 6130.233720784902, 6137.785177518855, 6283.560150789493, 6288.0, 6292.653904035322, 6296.244450665858, 6304.495640348761, 6179.28938172107, 6219.222597175353, 6220.222472190976, 6225.750969961151, 6251.687415629201, 6082.878342433127, 6097.993831017832, 6121.57491608479, 6132.967444181115, 6245.5628106033055, 5017.54842064216, 5035.571976381975, 5057.494250574913, 5069.923951140736, 5070.062038522885, 4476.7090139140855, 4482.7758612069265, 4483.036147228361, 4499.0, 4527.456705195332, 5559.16612508127, 5619.100943849046, 5736.311642602831, 5752.17505670289, 5784.045632470679, 6210.285817131088, 6256.217972753406, 6257.4994000480765, 6331.113644089831, 6348.77779277723, 5697.6296540724725, 5737.053386191315, 5777.8555536111935, 5778.0, 5803.448672376117, 5355.812546560852, 5494.5054945055135, 5499.890002199933, 5507.779688812403, 5518.19986102013, 6232.626042437469, 6269.0, 6302.243730752339, 6312.274088479883, 6323.841903952438, 6291.685415729104, 6294.402031806971, 6299.464545513682, 6304.779332723333, 6320.747170113328, 5267.657602255841, 6248.0, 6286.214223222098, 6308.306086330592, 6325.810225693236, 6047.727852246748, 6107.643995706967, 6122.672617327995, 6125.84685382869, 6176.320604733565, 6280.214973128359, 6290.779822706183, 6308.52686048539, 6318.115463835159, 6331.2085989251345, 5466.863328416822, 5989.813717992814, 6154.907676384768, 6173.074038894202, 6180.6909654517995, 5936.584439089395, 6045.063015232646, 6050.969745151246, 6052.515798736179, 6125.693715314305, 5902.203202567598, 6017.518598512021, 6018.578699490994, 6027.20356872586, 6074.757009719562, 6100.993336099494, 6174.073888916699, 6182.350853160354, 6211.503079753518, 6212.844678883064, 5818.534517238695, 5852.7658893643775, 5953.940460595339, 6002.639841609517, 6055.0], "value": 5726.9438672841325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.9052189562086, 510.8722819295176, 527.9419263880974, 536.7423636654403, 557.8131326005788, 29888.0, 39021.41467877984, 40141.799291003575, 40183.59816401835, 42437.57562424375, 41219.79390103053, 41690.58309416905, 41754.0, 41785.0, 41785.79107104468, 8693.174148455886, 9647.951760241189, 9801.656942007032, 9814.90185098147, 9822.65620703272, 8704.738857834274, 10340.689779306595, 11888.940555297211, 11920.225185362968, 12135.696607584792, 11971.042316614694, 12022.939885300604, 12026.158168928136, 12031.338276394796, 12048.216865903732, 12049.698757531045, 12111.757764844653, 12147.08896832741, 12158.9664878485, 12159.027277817753, 11834.0, 11915.0, 11926.555056213456, 11937.985271251953, 11940.940295298555, 39475.802620987, 39701.80149099265, 39727.40408893869, 39739.00652483682, 39741.80129099336, 3564.055525285801, 3620.0587847159663, 3632.473291372736, 3672.467492213614, 3872.6514613684903, 30128.54807177894, 30617.0, 31335.529967050512, 31491.685083149103, 31652.683473165205, 3197.876697349861, 3208.9358212835614, 3239.5464634951127, 3286.5727455430642, 3317.9668203318142, 380269.19730802614, 380358.0, 380581.0, 380935.0, 385628.3592910172, 54941.0, 55210.723946380014, 55221.44778552243, 55518.0, 55533.0, 53972.0, 58995.70502147462, 59083.40916590865, 59137.70431147817, 60755.0, 15360.769588456182, 15578.84421155774, 15581.14303713284, 15591.610209744847, 15625.296861641253, 11030.669079927615, 11243.494042768096, 11969.88030119705, 12135.635930922086, 12152.756944861054, 14706.264686765833, 15021.399144034334, 15023.624409389853, 15071.21182581226, 15179.924100379649, 7100.396466300423, 7110.64446777659, 7127.7148914042855, 7144.464165187528, 7215.783526494213, 796.665400531778, 919.6459363145103, 931.4923366765129, 931.7624005878457, 1062.4209805655937, 26548.60177097345, 29372.706272937423, 29539.704602954123, 30004.54993175104, 30121.246968825955, 962.3985009369144, 1042.9113525350278, 1054.314695447965, 1059.5549869055014, 1068.0494360019588, 14681.265936703336, 15186.899537125135, 15518.284300247411, 15540.222988850739, 15620.687586248212, 669738.0, 674309.0, 676271.0, 677615.0, 679649.0, 56404.5898852532, 56540.15189772157, 56759.43240567624, 56830.71584642133, 56842.0, 1205.409349418796, 1327.9070465067546, 1341.8658134186503, 1366.0, 1369.7876829091506, 26676.99535209125, 27365.04222352208, 30270.394592108474, 30661.386772264876, 30966.380672386877, 47335.76332118317, 47746.80632984064, 47757.283640744725, 47774.76112619415, 47973.760131199124, 545347.0, 546829.0, 548015.0, 548655.0, 549740.0, 23781.83817831838, 25192.0, 25949.22152335433, 26706.732932670424, 38085.61914380821, 45748.0, 46264.0, 47245.29132062953, 47263.0, 47460.7626961863, 37958.24083518259, 38238.42642360311, 38274.0431489215, 39342.0, 39498.40752388659, 37900.81049594734, 38368.6163138365, 38806.4179037309, 39353.0, 39944.841868406664, 30283.0, 36952.81523592365, 37212.44181337336, 37679.62320376871, 37692.86921392362, 24511.877440612683, 29019.85490072536, 31886.0, 34116.805911792966, 34219.82890085533, 22722.77277227273, 23070.0, 24232.75767242305, 24900.377490562158, 25438.236852894443], "value": 19786.949879497457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.50369482724165, 377.09873402567865, 377.3208225194649, 388.87167234812506, 411.8640848519989, 15146.924265378671, 15300.15849128299, 19911.502212444695, 20190.0, 20304.187832486703, 20275.46556680415, 20524.87113208773, 20775.688364674505, 20919.606882554683, 21158.894205528988, 5779.768809247625, 5836.9124463132985, 6124.816255512342, 6125.632462052269, 6138.386161383871, 6114.633122012671, 6143.44708976192, 6154.046122850943, 6161.661108639023, 6171.105189747484, 3923.313420151462, 5044.369453818273, 6817.5227734058635, 6836.213835408942, 6899.931000689979, 6566.63883486408, 6741.898871516931, 6866.073080134192, 6879.449644028491, 6892.241853396123, 5951.9107213391835, 5960.195373624549, 5974.790882319098, 5975.073863551156, 5992.310884248323, 13385.129966552144, 20094.69857952132, 25129.0, 26147.215583532525, 26243.212703618923, 2123.5115923337717, 2321.93034208974, 2344.39045848079, 2782.220978126128, 2979.0467050543834, 9741.172000379976, 9884.357516761387, 10292.485375731258, 10349.551062851207, 10403.323783954018, 1832.6059897122182, 1851.0837135617821, 1860.4046705054388, 1872.0452569189674, 1922.7115932610081, 85154.14845851524, 128298.35850820779, 130753.34623326917, 131968.0, 133343.0, 11006.944965275123, 11493.0, 11521.366324852046, 11551.76896462066, 11709.414529273672, 14467.710645787025, 14490.85509144916, 14495.565133046026, 14499.92750036264, 14501.0, 8103.878441823377, 8359.164083591591, 8370.79073023167, 8519.574021299035, 8525.872111918326, 8232.753017409488, 8252.422330436932, 8256.0, 8437.746867593982, 8442.282405995436, 4382.802773875183, 4434.627474301234, 4454.688171828006, 4533.252013417749, 4611.432113081569, 1521.965063756656, 1817.790954040276, 1820.4708045241796, 1881.7741870975572, 1891.0, 628.3841835001724, 698.0147116981713, 790.2887401338841, 802.8394321135796, 931.4923366765129, 15258.389664413522, 19505.758157389784, 20845.68731469029, 20848.791512084987, 21217.681734773993, 929.2333824594601, 946.9337146399686, 952.4333021851987, 960.706984369774, 1001.2440607341556, 8830.851989241357, 9898.96060913608, 10053.145482633912, 10478.580856765644, 10904.836427453594, 587178.0, 588337.0, 590800.0, 600908.0, 601287.0, 131483.0, 132879.33307560423, 136165.0, 136305.318473409, 137555.0, 993.6124911284605, 1003.0922015575916, 1031.29356390871, 1032.9173666106694, 1036.8237399642078, 15070.547883563511, 15265.771013435029, 18947.715784263524, 19009.33467328637, 19147.71278430797, 56907.0, 56925.57686057882, 57057.42942570521, 57141.42858571527, 57558.0, 83062.0, 85724.0, 86346.0, 87011.0, 87273.56363218144, 7901.249381308767, 7955.761327160194, 7995.760127196193, 8402.537860417735, 8441.198086181803, 9264.53677316145, 12029.338386388832, 12808.74382512326, 13172.341382931007, 13191.868081319064, 10813.837792432962, 11259.268147570381, 11268.098552115647, 11372.31766094037, 11390.601328953448, 10837.945810270898, 10942.234043617189, 11056.170787191153, 11265.436728163722, 11371.943140284577, 9354.391964522285, 10505.369677819355, 10528.315659482108, 11117.22179447431, 11640.592579260025, 7896.447248692536, 8109.75670729879, 8111.716089936824, 8132.6746930122135, 8439.451435656663, 8152.554233729976, 10075.790905091437, 10850.728731781453, 11169.106471482424, 11181.888181118085], "value": 9517.163117715803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.1989046353115, 1465.6042868425525, 1656.4699296225206, 1832.3311991123244, 1894.2233684189484, 8382.538960357186, 8946.597403116859, 8950.820983580332, 8952.507612081341, 8958.955205223981, 7792.805179870506, 8027.719029833957, 8406.327493800496, 8631.65473381064, 8739.781505462366, 2361.0319768894756, 2400.59189937711, 2400.639904014403, 2406.3743426709007, 2407.0492155598527, 2147.0982187481295, 2246.2138251611887, 2414.263649586875, 2416.8187385946035, 2431.0397393029743, 2376.786089251967, 2387.0929046962215, 2393.7965272951733, 2405.687260656121, 2408.4821763320883, 2360.197532838843, 2376.5128148729555, 2384.3800611840875, 2386.7135943686694, 2399.2082612737754, 2326.592846251899, 2351.106579499796, 2376.4415362389823, 2378.595638741418, 2387.6418537219383, 8819.647214111428, 8911.242544383735, 8912.153345432174, 8915.063918288615, 8927.151920567536, 5062.367204099488, 5236.188390799432, 5241.947580524184, 5252.422233554306, 5263.6578622389425, 3607.801570913599, 3612.8916132516065, 3682.742208045438, 3683.5027271318295, 3687.631236876318, 1080.378782200238, 1084.7233955341337, 1085.4409978860892, 1103.773726386089, 1109.4951796932376, 9709.126178643884, 11632.941835290854, 11637.825432618518, 11646.359450230233, 11653.475593598308, 3746.8875933722034, 4632.768361581908, 4805.8558243252755, 4833.540813622701, 4842.394700662418, 9879.456629885426, 9883.209343252522, 9884.65403710881, 9884.80230395388, 9897.109260166619, 4535.750533720677, 5351.81268655603, 5351.973240133774, 5357.678539287655, 5362.517373436332, 4378.912421751611, 4542.909141817145, 4738.810447582127, 4841.12859685253, 4892.559669629751, 3841.250956063541, 3892.1826416452295, 3961.7028722845903, 3991.7006224533275, 3998.8400463981116, 1089.7057794395469, 1275.789494733377, 1286.5175559165314, 1289.9871001290055, 1305.8432988041495, 817.3216230528647, 858.3776761847611, 892.8526793079199, 920.9401388909699, 955.044955044955, 5717.113847353667, 5726.284214473191, 5808.79669211584, 5963.29592843653, 5995.700214989233, 384.74414514347643, 437.4728452215073, 437.54495324861784, 450.3784777007708, 453.916025535277, 3573.3746594345885, 3824.254270417242, 3873.4577159197734, 3908.4918960534947, 3995.400689896481, 10506.159507239403, 10760.192985526117, 10854.78290434187, 10875.945620271848, 10878.782424351468, 10792.568297268179, 10800.51397687106, 10803.621873234399, 10807.67576972692, 10811.135109191246, 6440.6135631862235, 7955.920440795518, 8164.183581641907, 8265.752027439186, 8266.297364724065, 4931.260310953386, 5603.495685388335, 5733.971330143323, 5776.451237132465, 6002.159697642246, 9798.559064841957, 9825.55784989663, 10022.24833137503, 10034.64878729241, 10174.491275436347, 10068.384692618385, 10162.491875406347, 10230.948845256024, 10298.845517317395, 10319.845202321821, 6820.283870193558, 7013.368796808108, 7207.819804504929, 7374.631268436664, 7480.401567874448, 8141.307988820779, 8392.83214335722, 8396.832063358577, 8405.621747021522, 8409.2431681149, 7328.374407183552, 7501.2123727007875, 7529.698812047676, 7562.810929726801, 7583.203763604963, 7301.160366557914, 7315.561066336037, 7359.411247100326, 7458.0, 7556.357709594746, 6850.45196384298, 7020.297970202939, 7024.192217894803, 7031.40233080194, 7036.753713619999, 4900.26496025599, 4930.901381972412, 4995.350604421402, 5057.671251368649, 5068.062408454448, 4954.445601223441, 4955.851324460272, 5146.4338922717725, 5222.321098257202, 5228.268042474133], "value": 4477.329399506731, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.84216838570404, 309.3210403165052, 314.763927054709, 319.17174931053904, 319.29117359461986, 4170.562090980445, 5348.304720386349, 5360.410354860967, 5414.43148469411, 5426.321709786277, 5250.396204436491, 5317.494837990384, 5351.277577527033, 5351.805759638549, 5365.195220716884, 3517.5402208083615, 3536.0, 3880.0687834919627, 4071.7149799514045, 4125.9174816503655, 3628.0, 4077.961918370818, 4118.258713431581, 4122.319817230154, 4124.278251306025, 3779.6787273081823, 4006.4775385353523, 4038.899027524306, 4042.2319759245797, 4070.6973768394128, 3190.840457977092, 3657.7073834093208, 3812.942805857914, 4051.6961227907877, 4058.5851418406, 2808.1575527341715, 3052.8320942348164, 3500.7549471537004, 3504.1590018395655, 3508.0705611913345, 4061.7969101544804, 4198.412222288882, 4673.766311684402, 5141.768620412053, 5169.508896654812, 4232.32282834748, 4254.361845723135, 4310.547392523771, 4637.420322459692, 4671.902103005791, 5023.824166154167, 5407.567394608422, 5594.916076258859, 5600.355959064678, 5641.887162256732, 3611.205534782344, 3905.344365831262, 3906.5312162540395, 3911.4523966644692, 3927.3323534999117, 5562.078734492174, 5815.505682016991, 5898.587098903078, 5964.821055368346, 5981.700914954235, 3275.5250488679008, 3841.8079096045085, 3910.687145028391, 3942.9211415771524, 3973.8609148679657, 3347.163209197701, 3435.9656403435647, 3773.9245215095543, 4000.6399424051974, 4047.5750046245307, 4625.375574297427, 4662.347271382009, 4663.0, 4667.299905014207, 4673.509281525391, 5133.897322053538, 5496.230527726121, 5593.328800543879, 5611.438856114438, 5647.576431767634, 1147.1511081799408, 1345.7981302804658, 1370.3490841850241, 1373.8214032175954, 1398.9930050349683, 791.7703865878946, 841.5399282245422, 848.8175042365921, 854.9871751923727, 863.4301361101643, 4019.718619696652, 4238.321868501087, 4810.278458231293, 5203.713795741195, 5253.632245742761, 4809.495003024702, 4949.82675606352, 5111.718855462911, 5748.5688573357165, 5780.104083867007, 5035.446100928895, 5254.97372513135, 5269.235960785742, 5275.498827611371, 5286.471352864683, 2531.544322022017, 2615.9346016349364, 2934.7212014858555, 2980.910572682823, 3042.893498727534, 5187.9883422732955, 5294.0, 5430.972845135828, 5613.663180209201, 6029.57792954489, 5641.956238095965, 5901.704914754245, 5943.257092863392, 5973.850653733604, 5973.880522389615, 4495.561420345523, 5325.414204437431, 5838.854028649318, 5969.149898315649, 5987.0, 4507.264703089269, 5446.645968012225, 5775.700467394802, 5782.855428614318, 5800.883982320414, 5685.317761868602, 5698.401667824819, 5705.315362156568, 5715.0, 5725.427457254241, 5730.275321041357, 5889.37803250989, 5947.6431414115295, 5970.835687040985, 6010.579259451796, 3014.653314868818, 3460.7231421486727, 3536.2573859488766, 3637.2907283080604, 3926.234384295035, 4778.781410740239, 4816.614670826255, 5037.496250375079, 5653.915191272216, 5751.424857514216, 4741.35991641124, 5302.606331947633, 5408.59435542328, 5627.718614069198, 5655.660660360391, 4292.549282325311, 4596.954030459787, 5563.332400112013, 5625.409332020079, 5664.943350566607, 4636.582707556337, 5359.418971403367, 5390.595705322195, 5459.754311056092, 5549.278593782944, 4802.559232230247, 5124.180131178993, 5267.657602255841, 5460.5085542301385, 5551.306086739158, 4257.978710106554, 4630.05537674171, 4787.061240197725, 5455.9454405455435, 5564.221009058654], "value": 4015.090388069464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [663.6018388966621, 725.2783480436966, 767.5739964319804, 798.6086817459445, 808.454293351988, 15171.772423413644, 16095.678086438264, 16120.113393763368, 16128.516144515654, 16141.515754527354, 12268.32524211168, 14469.131852088882, 14706.0, 14742.0, 14761.92619036906, 666.7066490744081, 683.9555428897106, 685.1367277230676, 691.2258270736781, 843.4981186194204, 666.7099811581953, 840.9159084091604, 856.5203486047802, 865.6840253307561, 872.1583671756754, 873.3493547307233, 885.9645614175425, 887.8756974023642, 889.7286327670058, 890.2521881619439, 733.5965219129484, 876.6537217798966, 876.9079246679071, 878.091175633223, 879.683314006957, 527.5146864884277, 542.8045903474746, 653.4249860123109, 654.9880434728356, 656.9146011018537, 12532.937335313356, 12575.0, 14241.359138838778, 14764.335604897806, 14816.925915370353, 14177.149371037667, 14777.778333325008, 14797.55607331771, 14820.777688334683, 14948.177850218233, 11943.0, 12020.038396928225, 12044.457999390048, 12236.265824050586, 12334.444949977273, 3789.412641040643, 3834.041489627593, 3845.5193100862393, 3866.845326186949, 3989.1024519483176, 126257.36871315677, 127526.0, 129415.35292323573, 130510.0, 131721.0, 11378.601748938747, 11540.769184616262, 11568.710782230512, 11608.593699220486, 11714.414279286002, 23939.521209575712, 23950.161744339213, 23985.0, 24001.27996160118, 24007.879960600087, 7974.282314591598, 8041.075276343178, 8219.424640275243, 8371.158345164054, 8386.916130838736, 4020.5175378954127, 4350.651947844165, 4540.341650460665, 4565.817367305337, 4588.082383523309, 3503.7197024238, 3633.6003039665616, 3636.8363423646, 3644.8177591120866, 3655.6709896108946, 518.5333200119846, 622.8380621038472, 633.2685747961112, 634.7556190866458, 641.4355367276767, 560.5711630602592, 587.4037851580649, 615.679846479828, 663.7909058646511, 664.249398180063, 9124.406913550598, 9387.249020078378, 9516.809663806824, 9607.615695372107, 9673.564689588986, 617.2562062714418, 618.6813790897692, 665.3645768291367, 669.581511555278, 670.8322919270182, 4589.931151032737, 4618.907621847611, 4619.95380046202, 4627.537246275346, 4675.345451636774, 164511.0, 167012.1550918079, 168450.0, 169669.0, 169993.0, 141132.588674114, 146242.0, 147393.0, 148292.0, 150630.0, 121502.78497214915, 122087.3895630534, 124261.37869310596, 124318.0, 127268.36365818112, 8846.380753347205, 9036.186743193144, 9070.410423322463, 9108.043655416352, 9202.907970920205, 57772.133417997924, 68756.65621671859, 68865.0, 70541.0, 71243.28756712367, 58806.411935881806, 75673.10817229393, 84857.1514284874, 99866.0, 108695.0, 11503.884961150281, 13218.416647930173, 13296.534621288596, 13349.866501335251, 13505.12216705911, 14919.701605968037, 15215.467458639338, 15278.465253716067, 15306.693866122838, 15590.298436570609, 13739.793903091262, 14011.789823152458, 14167.787483187554, 14361.712765744418, 14799.18604476721, 12337.50649974027, 13761.17432954026, 13885.791713124514, 14245.857541424453, 14395.640108997359, 12871.420786064837, 12988.220706757626, 13265.270410127536, 13350.265735384648, 13589.52436664712, 11337.093032557541, 11562.94218528902, 11697.23967942081, 11729.237599556001, 11959.521619135137, 10918.845473709527, 11397.487113080097, 11498.597549085742, 11633.47649355764, 11663.183577149857], "value": 7930.596381728293, "unit": "score"}], "name": "dromaeo_css", "value": 7319.467264652212, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 116.0, 112.0, 113.0, 110.0, 114.0, 112.0, 113.0, 122.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 145.0, 128.0, 161.0, 106.0, 129.0, 126.0, 107.0, 175.0, 136.0], "value": 136.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 203.0, 259.0, 192.0, 184.0, 185.0, 217.0, 181.0, 182.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 150.0, 58.0, 58.0, 57.0, 67.0, 139.0, 57.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 129.0, 70.0, 68.0, 79.0, 149.0, 98.0, 102.0, 119.0], "value": 98.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 114.0, 87.0, 83.0, 86.0, 84.0, 86.0, 83.0, 86.0, 84.0], "value": 88.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 93.0, 93.0, 93.0, 106.0, 149.0, 92.0, 92.0, 92.0], "value": 99.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 83.0, 81.0, 87.0, 68.0, 127.0, 131.0, 106.0, 84.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 56.0, 55.0, 54.0, 54.0, 54.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 72.0, 78.0, 76.0, 73.0, 70.0, 71.0, 70.0, 71.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 85.0, 86.0, 81.0, 103.0, 106.0, 85.0, 89.0, 90.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 161.0, 150.0, 136.0, 135.0, 139.0, 136.0, 136.0, 178.0, 139.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 232.0, 194.0, 167.0, 229.0, 178.0, 167.0, 167.0, 167.0, 168.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 87.0, 88.0, 67.0, 66.0, 66.0, 67.0, 69.0, 66.0, 66.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1524.6999999999998, "alertThreshold": 2.0}]} 16:33:37 INFO - Return code: 0 16:33:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:33:37 INFO - # TBPL SUCCESS # 16:33:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:33:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:33:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:33:37 INFO - 2016-09-07 16:33:37.254 screenresolution[1667:10590] starting screenresolution argv=screenresolution get 16:33:37 INFO - 2016-09-07 16:33:37.257 screenresolution[1667:10590] Display 0: 1600x1200x32@60 16:33:37 INFO - 2016-09-07 16:33:37.263 screenresolution[1668:10593] starting screenresolution argv=screenresolution list 16:33:37 INFO - Available Modes on Display 0 16:33:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:33:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:33:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:33:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:33:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:33:37 INFO - Intel Iris: 16:33:37 INFO - Chipset Model: Intel Iris 16:33:37 INFO - Type: GPU 16:33:37 INFO - Bus: Built-In 16:33:37 INFO - VRAM (Dynamic, Max): 1536 MB 16:33:37 INFO - Vendor: Intel (0x8086) 16:33:37 INFO - Device ID: 0x0a2e 16:33:37 INFO - Revision ID: 0x0009 16:33:37 INFO - Displays: 16:33:37 INFO - Display: 16:33:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:33:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:33:37 INFO - Display Serial Number: 1600x1200 60 16:33:37 INFO - Main Display: Yes 16:33:37 INFO - Mirror: Off 16:33:37 INFO - Online: Yes 16:33:37 INFO - Rotation: Supported 16:33:37 INFO - Return code: 0 16:33:37 INFO - Running post-action listener: _resource_record_post_action 16:33:37 INFO - [mozharness: 2016-09-07 23:33:37.498773Z] Finished run-tests step (success) 16:33:37 INFO - Running post-run listener: _resource_record_post_run 16:33:37 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 32136192; Write bytes: 706724352; Read time: 198; Write time: 2032 16:33:37 INFO - TinderboxPrint: CPU usage
53.5% 16:33:37 INFO - TinderboxPrint: I/O read bytes / time
32,136,192 / 198 16:33:37 INFO - TinderboxPrint: I/O write bytes / time
706,724,352 / 2,032 16:33:37 INFO - TinderboxPrint: CPU idle
2,257.2 (46.5%) 16:33:37 INFO - TinderboxPrint: CPU system
971.1 (20.0%) 16:33:37 INFO - TinderboxPrint: CPU user
1,625.5 (33.5%) 16:33:37 INFO - TinderboxPrint: Swap in / out
434,507,776 / 0 16:33:37 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400562688; Write bytes: 395425792; Read time: 29556; Write time: 864 16:33:37 INFO - run-tests - Wall time: 1179s; CPU: 53.0%; Read bytes: 30067712; Write bytes: 296491520; Read time: 179; Write time: 1130 16:33:37 INFO - Running post-run listener: _upload_blobber_files 16:33:37 INFO - Blob upload gear active. 16:33:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:33:37 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 16:33:37 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'] 16:33:37 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 16:33:38 INFO - (blobuploader) - INFO - Open directory for files ... 16:33:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:33:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:33:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:39 INFO - (blobuploader) - INFO - Done attempting. 16:33:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:33:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:33:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:40 INFO - (blobuploader) - INFO - Done attempting. 16:33:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:33:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:33:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:33:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:33:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:33:43 INFO - (blobuploader) - INFO - Done attempting. 16:33:43 INFO - (blobuploader) - INFO - Iteration through files over. 16:33:43 INFO - Return code: 0 16:33:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:33:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:33:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c735ceb62dffa99091590ddff3c394789fd85969cfa2e3159e474e322d224df3cfe2852190d9be44dc40302d60a7b161ebef5547deec976719032b5a2e901fe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62b54e9ab9a07b041e0b783c6047f8b6f2b35f123f1cea903ad424a0126f5a27f18d7d3913bccfc658fe3b3340513a8180746f895a9cf7432a0ad0c88f548db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32fbbdec437e4a8ac88fae6223041c8766ce8e47121cd67fe3b813268b7630cf026d5d6e98c1ea6ca31591ae7caa025cc9cf5a234dec9116039a5def49c44cf"} 16:33:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:33:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:33:43 INFO - Contents: 16:33:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c735ceb62dffa99091590ddff3c394789fd85969cfa2e3159e474e322d224df3cfe2852190d9be44dc40302d60a7b161ebef5547deec976719032b5a2e901fe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62b54e9ab9a07b041e0b783c6047f8b6f2b35f123f1cea903ad424a0126f5a27f18d7d3913bccfc658fe3b3340513a8180746f895a9cf7432a0ad0c88f548db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32fbbdec437e4a8ac88fae6223041c8766ce8e47121cd67fe3b813268b7630cf026d5d6e98c1ea6ca31591ae7caa025cc9cf5a234dec9116039a5def49c44cf"} 16:33:43 INFO - Running post-run listener: copy_logs_to_upload_dir 16:33:43 INFO - Copying logs to upload dir... 16:33:43 INFO - mkdir: /builds/slave/test/build/upload/logs 16:33:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.433465 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-09-07 16:33:43.294754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 16:33:43.297870) ========= 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.eW74AECKul/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.MiRzlvjVOh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c735ceb62dffa99091590ddff3c394789fd85969cfa2e3159e474e322d224df3cfe2852190d9be44dc40302d60a7b161ebef5547deec976719032b5a2e901fe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62b54e9ab9a07b041e0b783c6047f8b6f2b35f123f1cea903ad424a0126f5a27f18d7d3913bccfc658fe3b3340513a8180746f895a9cf7432a0ad0c88f548db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32fbbdec437e4a8ac88fae6223041c8766ce8e47121cd67fe3b813268b7630cf026d5d6e98c1ea6ca31591ae7caa025cc9cf5a234dec9116039a5def49c44cf"} build_url:https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011332 build_url: 'https://queue.taskcluster.net/v1/task/MeUHIqGUTAKYWBWg_qpwIg/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c735ceb62dffa99091590ddff3c394789fd85969cfa2e3159e474e322d224df3cfe2852190d9be44dc40302d60a7b161ebef5547deec976719032b5a2e901fe4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/62b54e9ab9a07b041e0b783c6047f8b6f2b35f123f1cea903ad424a0126f5a27f18d7d3913bccfc658fe3b3340513a8180746f895a9cf7432a0ad0c88f548db4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b32fbbdec437e4a8ac88fae6223041c8766ce8e47121cd67fe3b813268b7630cf026d5d6e98c1ea6ca31591ae7caa025cc9cf5a234dec9116039a5def49c44cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-07 16:33:43.331323) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 16:33:43.331650) ========= 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.eW74AECKul/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.MiRzlvjVOh/Listeners TMPDIR=/var/folders/xl/2fl64x7x0nl14d20xydz31pc00000w/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.005261 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-07 16:33:43.383319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 16:33:43.383625) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-07 16:33:43.383937) ========= ========= Total master_lag: 0.53 =========