builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0247 starttime: 1467945635.02 results: success (0) buildid: 20160707173727 builduid: 47631279b5234a2f9458140b0bf788da revision: 89cae7a45e2388ea0079f9570eadfd538cd98930 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:35.023418) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:35.023831) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-07 19:40:35.024115) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-07 19:40:36.638324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:36.638709) ========= 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.OPLIdiP2YT/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.pufd3dBZqm/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-07 19:40:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-07-07 19:40:36 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171209 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:36.835550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:36.836301) ========= 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.OPLIdiP2YT/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.pufd3dBZqm/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.025834 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:36.887749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:36.888169) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 89cae7a45e2388ea0079f9570eadfd538cd98930 --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 89cae7a45e2388ea0079f9570eadfd538cd98930 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OPLIdiP2YT/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.pufd3dBZqm/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-07 19:40:36,970 truncating revision to first 12 chars 2016-07-07 19:40:36,970 Setting DEBUG logging. 2016-07-07 19:40:36,970 attempt 1/10 2016-07-07 19:40:36,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/89cae7a45e23?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 19:40:37,601 unpacking tar archive at: fx-team-89cae7a45e23/testing/mozharness/ program finished with exit code 0 elapsedTime=0.917565 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:37.832486) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:37.832928) ========= script_repo_revision: 89cae7a45e2388ea0079f9570eadfd538cd98930 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:37.833456) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:37.833794) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 19:40:37.854935) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 19:40:37.855272) ========= /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.OPLIdiP2YT/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.pufd3dBZqm/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:40:38 INFO - MultiFileLogger online at 20160707 19:40:38 in /builds/slave/test 19:40:38 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 19:40:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:40:38 INFO - {'append_to_log': False, 19:40:38 INFO - 'base_work_dir': '/builds/slave/test', 19:40:38 INFO - 'blob_upload_branch': 'Fx-Team', 19:40:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:40:38 INFO - 'branch': 'Fx-Team', 19:40:38 INFO - 'buildbot_json_path': 'buildprops.json', 19:40:38 INFO - 'config_files': ('talos/mac_config.py',), 19:40:38 INFO - 'default_actions': ('clobber', 19:40:38 INFO - 'read-buildbot-config', 19:40:38 INFO - 'download-and-extract', 19:40:38 INFO - 'populate-webroot', 19:40:38 INFO - 'create-virtualenv', 19:40:38 INFO - 'install', 19:40:38 INFO - 'run-tests'), 19:40:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:40:38 INFO - 'download_minidump_stackwalk': True, 19:40:38 INFO - 'download_symbols': 'ondemand', 19:40:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:40:38 INFO - 'tooltool.py': '/tools/tooltool.py', 19:40:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:40:38 INFO - '/tools/misc-python/virtualenv.py')}, 19:40:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:40:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:40:38 INFO - 'installer_path': 'installer.exe', 19:40:38 INFO - 'log_level': 'info', 19:40:38 INFO - 'log_name': 'talos', 19:40:38 INFO - 'log_to_console': True, 19:40:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:40:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:40:38 INFO - 'opt_config_files': (), 19:40:38 INFO - 'pip_index': False, 19:40:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:40:38 INFO - 'cmd': ('bash', 19:40:38 INFO - '-c', 19:40:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:40:38 INFO - 'enabled': True, 19:40:38 INFO - 'halt_on_failure': False, 19:40:38 INFO - 'name': 'check_screen_resolution'},), 19:40:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:40:38 INFO - 'cmd': ('bash', 19:40:38 INFO - '-c', 19:40:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:40:38 INFO - 'enabled': True, 19:40:38 INFO - 'halt_on_failure': False, 19:40:38 INFO - 'name': 'check_screen_resolution'},), 19:40:38 INFO - 'run_cmd_checks_enabled': True, 19:40:38 INFO - 'sps_profile': False, 19:40:38 INFO - 'sps_profile_interval': 0, 19:40:38 INFO - 'suite': 'dromaeojs', 19:40:38 INFO - 'system_bits': '32', 19:40:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:40:38 INFO - 'title': 't-yosemite-r7-0247', 19:40:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:40:38 INFO - 'use_talos_json': True, 19:40:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:40:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:40:38 INFO - 'work_dir': 'build'} 19:40:38 INFO - ##### 19:40:38 INFO - ##### Running clobber step. 19:40:38 INFO - ##### 19:40:38 INFO - Running pre-action listener: _resource_record_pre_action 19:40:38 INFO - Running main action method: clobber 19:40:38 INFO - rmtree: /builds/slave/test/build 19:40:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:40:39 INFO - Running post-action listener: _resource_record_post_action 19:40:39 INFO - ##### 19:40:39 INFO - ##### Finished clobber step (success) 19:40:39 INFO - ##### 19:40:39 INFO - ##### 19:40:39 INFO - ##### Running read-buildbot-config step. 19:40:39 INFO - ##### 19:40:39 INFO - Running pre-action listener: _resource_record_pre_action 19:40:39 INFO - Running main action method: read_buildbot_config 19:40:39 INFO - Using buildbot properties: 19:40:39 INFO - { 19:40:39 INFO - "project": "", 19:40:39 INFO - "product": "firefox", 19:40:39 INFO - "script_repo_revision": "production", 19:40:39 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 19:40:39 INFO - "repository": "", 19:40:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 19:40:39 INFO - "buildid": "20160707173727", 19:40:39 INFO - "pgo_build": "False", 19:40:39 INFO - "basedir": "/builds/slave/test", 19:40:39 INFO - "buildnumber": 794, 19:40:39 INFO - "slavename": "t-yosemite-r7-0247", 19:40:39 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 19:40:39 INFO - "platform": "yosemite_r7", 19:40:39 INFO - "scheduler": "tests-fx-team-macosx64-talos", 19:40:39 INFO - "branch": "fx-team", 19:40:39 INFO - "repo_path": "integration/fx-team", 19:40:39 INFO - "revision": "89cae7a45e2388ea0079f9570eadfd538cd98930", 19:40:39 INFO - "stage_platform": "macosx64", 19:40:39 INFO - "builduid": "47631279b5234a2f9458140b0bf788da", 19:40:39 INFO - "slavebuilddir": "test" 19:40:39 INFO - } 19:40:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 19:40:39 INFO - Running post-action listener: _resource_record_post_action 19:40:39 INFO - ##### 19:40:39 INFO - ##### Finished read-buildbot-config step (success) 19:40:39 INFO - ##### 19:40:39 INFO - ##### 19:40:39 INFO - ##### Running download-and-extract step. 19:40:39 INFO - ##### 19:40:39 INFO - Running pre-action listener: _resource_record_pre_action 19:40:39 INFO - Running main action method: download_and_extract 19:40:39 INFO - mkdir: /builds/slave/test/build/tests 19:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:39 INFO - https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:40:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:40:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:40:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 19:40:42 INFO - Downloaded 1199 bytes. 19:40:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:40:42 INFO - Using the following test package requirements: 19:40:42 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:40:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:40:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:40:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'jsshell-mac.zip'], 19:40:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:40:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:40:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:40:42 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:40:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:40:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:40:42 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:40:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:40:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:42 INFO - https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:40:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:40:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:40:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:40:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:40:44 INFO - Downloaded 18806276 bytes. 19:40:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:40:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:40:47 INFO - Return code: 0 19:40:47 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:47 INFO - https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:40:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:40:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:40:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:40:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:40:48 INFO - Downloaded 18806276 bytes. 19:40:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:40:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:40:51 INFO - Return code: 0 19:40:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:51 INFO - https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:40:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:40:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:40:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:40:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:40:53 INFO - Downloaded 14403333 bytes. 19:40:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:40:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:40:53 INFO - Return code: 0 19:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:40:53 INFO - https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:40:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:40:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:40:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:40:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 19:40:56 INFO - Downloaded 112425466 bytes. 19:40:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:40:56 INFO - mkdir: /builds/slave/test/properties 19:40:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:40:56 INFO - Writing to file /builds/slave/test/properties/build_url 19:40:56 INFO - Contents: 19:40:56 INFO - build_url:https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:40:57 INFO - Running post-action listener: _resource_record_post_action 19:40:57 INFO - Running post-action listener: set_extra_try_arguments 19:40:57 INFO - ##### 19:40:57 INFO - ##### Finished download-and-extract step (success) 19:40:57 INFO - ##### 19:40:57 INFO - ##### 19:40:57 INFO - ##### Running populate-webroot step. 19:40:57 INFO - ##### 19:40:57 INFO - Running pre-action listener: _resource_record_pre_action 19:40:57 INFO - Running main action method: populate_webroot 19:40:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:40:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:40:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:40:57 INFO - '--tppagecycles', 19:40:57 INFO - '7'], 19:40:57 INFO - 'tests': ['tsvgm']}}, 19:40:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:40:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:40:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:40:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:40:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:40:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['damp', 'tps']}, 19:40:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'tests': ['damp', 'tps']}, 19:40:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['dromaeo_dom']}, 19:40:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:40:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['basic_compositor_video']}, 19:40:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:40:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['a11yr', 19:40:57 INFO - 'ts_paint', 19:40:57 INFO - 'tpaint', 19:40:57 INFO - 'sessionrestore', 19:40:57 INFO - 'sessionrestore_no_auto_restore', 19:40:57 INFO - 'tabpaint']}, 19:40:57 INFO - 'other-e10s': {'tests': ['a11yr', 19:40:57 INFO - 'ts_paint', 19:40:57 INFO - 'tpaint', 19:40:57 INFO - 'sessionrestore', 19:40:57 INFO - 'sessionrestore_no_auto_restore', 19:40:57 INFO - 'tabpaint']}, 19:40:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:40:57 INFO - 'ts_paint', 19:40:57 INFO - 'tpaint', 19:40:57 INFO - 'sessionrestore', 19:40:57 INFO - 'sessionrestore_no_auto_restore', 19:40:57 INFO - 'tabpaint']}, 19:40:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:40:57 INFO - 'ts_paint', 19:40:57 INFO - 'tpaint', 19:40:57 INFO - 'sessionrestore', 19:40:57 INFO - 'sessionrestore_no_auto_restore', 19:40:57 INFO - 'tabpaint']}, 19:40:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['a11yr', 19:40:57 INFO - 'ts_paint', 19:40:57 INFO - 'tpaint', 19:40:57 INFO - 'sessionrestore', 19:40:57 INFO - 'sessionrestore_no_auto_restore', 19:40:57 INFO - 'tabpaint']}, 19:40:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['a11yr', 19:40:57 INFO - 'ts_paint', 19:40:57 INFO - 'tpaint', 19:40:57 INFO - 'sessionrestore', 19:40:57 INFO - 'sessionrestore_no_auto_restore', 19:40:57 INFO - 'tabpaint']}, 19:40:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['tsvgx', 19:40:57 INFO - 'tsvgr_opacity', 19:40:57 INFO - 'tart', 19:40:57 INFO - 'tscrollx', 19:40:57 INFO - 'cart']}, 19:40:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:40:57 INFO - 'tsvgr_opacity', 19:40:57 INFO - 'tart', 19:40:57 INFO - 'tscrollx', 19:40:57 INFO - 'cart']}, 19:40:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'talos_options': ['--disable-e10s'], 19:40:57 INFO - 'tests': ['tp5o']}, 19:40:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'tests': ['tp5o']}, 19:40:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'talos_options': ['--disable-e10s', 19:40:57 INFO - '--xperf_path', 19:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:57 INFO - 'tests': ['tp5n']}, 19:40:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:40:57 INFO - 'talos_options': ['--xperf_path', 19:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:40:57 INFO - 'tests': ['tp5n']}}, 19:40:57 INFO - 'talos.zip': {'path': '', 19:40:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:40:57 INFO - Running post-action listener: _resource_record_post_action 19:40:57 INFO - ##### 19:40:57 INFO - ##### Finished populate-webroot step (success) 19:40:57 INFO - ##### 19:40:57 INFO - ##### 19:40:57 INFO - ##### Running create-virtualenv step. 19:40:57 INFO - ##### 19:40:57 INFO - Running pre-action listener: _resource_record_pre_action 19:40:57 INFO - Running main action method: create_virtualenv 19:40:57 INFO - Creating virtualenv /builds/slave/test/build/venv 19:40:57 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 19:40:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:40:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:40:57 INFO - Using real prefix '/tools/python27' 19:40:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:40:58 INFO - Installing distribute.............................................................................................................................................................................................done. 19:41:01 INFO - Installing pip.................done. 19:41:01 INFO - Return code: 0 19:41:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:41:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:01 INFO - 'HOME': '/Users/cltbld', 19:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:01 INFO - 'LOGNAME': 'cltbld', 19:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:01 INFO - 'MOZ_NO_REMOTE': '1', 19:41:01 INFO - 'NO_EM_RESTART': '1', 19:41:01 INFO - 'PAGER': '/bin/cat', 19:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:01 INFO - 'PWD': '/builds/slave/test', 19:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:01 INFO - 'SHELL': '/bin/bash', 19:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:01 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:01 INFO - 'USER': 'cltbld', 19:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:01 INFO - 'XPC_FLAGS': '0x0', 19:41:01 INFO - 'XPC_SERVICE_NAME': '0', 19:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:01 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 19:41:01 INFO - Cleaning up... 19:41:01 INFO - Return code: 0 19:41:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41: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', '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 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41: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', 'psutil>=3.1.1'] in /builds/slave/test/build 19:41: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 psutil>=3.1.1 19:41:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:01 INFO - 'HOME': '/Users/cltbld', 19:41:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:01 INFO - 'LOGNAME': 'cltbld', 19:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:01 INFO - 'MOZ_NO_REMOTE': '1', 19:41:01 INFO - 'NO_EM_RESTART': '1', 19:41:01 INFO - 'PAGER': '/bin/cat', 19:41:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:01 INFO - 'PWD': '/builds/slave/test', 19:41:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:01 INFO - 'SHELL': '/bin/bash', 19:41:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:01 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:01 INFO - 'USER': 'cltbld', 19:41:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:01 INFO - 'XPC_FLAGS': '0x0', 19:41:01 INFO - 'XPC_SERVICE_NAME': '0', 19:41:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:01 INFO - Downloading/unpacking psutil>=3.1.1 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:41:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:41:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:41:04 INFO - Installing collected packages: psutil 19:41:04 INFO - Running setup.py install for psutil 19:41:04 INFO - building 'psutil._psutil_osx' extension 19:41:04 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 19:41:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 19:41:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 19:41:05 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 19:41:05 INFO - building 'psutil._psutil_posix' extension 19:41:05 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 19:41:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:41:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:41:05 INFO - ^ 19:41:05 INFO - 1 warning generated. 19:41:05 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 19:41:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:41:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:41:05 INFO - Successfully installed psutil 19:41:05 INFO - Cleaning up... 19:41:05 INFO - Return code: 0 19:41:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:05 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 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:05 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 19:41:05 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 19:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:05 INFO - 'HOME': '/Users/cltbld', 19:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:05 INFO - 'LOGNAME': 'cltbld', 19:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:05 INFO - 'MOZ_NO_REMOTE': '1', 19:41:05 INFO - 'NO_EM_RESTART': '1', 19:41:05 INFO - 'PAGER': '/bin/cat', 19:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:05 INFO - 'PWD': '/builds/slave/test', 19:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:05 INFO - 'SHELL': '/bin/bash', 19:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:05 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:05 INFO - 'USER': 'cltbld', 19:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:05 INFO - 'XPC_FLAGS': '0x0', 19:41:05 INFO - 'XPC_SERVICE_NAME': '0', 19:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:41:05 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 19:41:05 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 19:41:05 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 19:41:05 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 19:41:05 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 19:41:05 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 19:41:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:41:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:41:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:41:08 INFO - Installing collected packages: mozsystemmonitor 19:41:08 INFO - Running setup.py install for mozsystemmonitor 19:41:08 INFO - Successfully installed mozsystemmonitor 19:41:08 INFO - Cleaning up... 19:41:08 INFO - Return code: 0 19:41:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41: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', '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 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:41: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 jsonschema==2.5.1 19:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:08 INFO - 'HOME': '/Users/cltbld', 19:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:08 INFO - 'LOGNAME': 'cltbld', 19:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:08 INFO - 'MOZ_NO_REMOTE': '1', 19:41:08 INFO - 'NO_EM_RESTART': '1', 19:41:08 INFO - 'PAGER': '/bin/cat', 19:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:08 INFO - 'PWD': '/builds/slave/test', 19:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:08 INFO - 'SHELL': '/bin/bash', 19:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:08 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:08 INFO - 'USER': 'cltbld', 19:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:08 INFO - 'XPC_FLAGS': '0x0', 19:41:08 INFO - 'XPC_SERVICE_NAME': '0', 19:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:08 INFO - Downloading/unpacking jsonschema==2.5.1 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:41:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41: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 19:41:11 INFO - Downloading functools32-3.2.3-2.tar.gz 19:41:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:41:11 INFO - warning: no files found matching '*.txt' 19:41:11 INFO - no previously-included directories found matching 'build' 19:41:11 INFO - no previously-included directories found matching 'dist' 19:41:11 INFO - no previously-included directories found matching '.git*' 19:41:11 INFO - Installing collected packages: jsonschema, functools32 19:41:11 INFO - Running setup.py install for functools32 19:41:12 INFO - warning: no files found matching '*.txt' 19:41:12 INFO - no previously-included directories found matching 'build' 19:41:12 INFO - no previously-included directories found matching 'dist' 19:41:12 INFO - no previously-included directories found matching '.git*' 19:41:12 INFO - Successfully installed jsonschema functools32 19:41:12 INFO - Cleaning up... 19:41:12 INFO - Return code: 0 19:41:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:12 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 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:12 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 19:41:12 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 19:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:12 INFO - 'HOME': '/Users/cltbld', 19:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:12 INFO - 'LOGNAME': 'cltbld', 19:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:12 INFO - 'MOZ_NO_REMOTE': '1', 19:41:12 INFO - 'NO_EM_RESTART': '1', 19:41:12 INFO - 'PAGER': '/bin/cat', 19:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:12 INFO - 'PWD': '/builds/slave/test', 19:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:12 INFO - 'SHELL': '/bin/bash', 19:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:12 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:12 INFO - 'USER': 'cltbld', 19:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:12 INFO - 'XPC_FLAGS': '0x0', 19:41:12 INFO - 'XPC_SERVICE_NAME': '0', 19:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:12 INFO - Downloading/unpacking blobuploader==1.2.4 19:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:14 INFO - Downloading blobuploader-1.2.4.tar.gz 19:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:41:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:41:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:41:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:41:15 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 19:41:15 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 19:41:15 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 19:41:15 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 19:41:15 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 19:41:15 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 19:41:15 INFO - Downloading docopt-0.6.1.tar.gz 19:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:41:16 INFO - Installing collected packages: blobuploader, requests, docopt 19:41:16 INFO - Running setup.py install for blobuploader 19:41:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:41:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:41:16 INFO - Running setup.py install for requests 19:41:16 INFO - Running setup.py install for docopt 19:41:16 INFO - Successfully installed blobuploader requests docopt 19:41:16 INFO - Cleaning up... 19:41:16 INFO - Return code: 0 19:41:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:41:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:41:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:16 INFO - 'HOME': '/Users/cltbld', 19:41:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:16 INFO - 'LOGNAME': 'cltbld', 19:41:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:16 INFO - 'MOZ_NO_REMOTE': '1', 19:41:16 INFO - 'NO_EM_RESTART': '1', 19:41:16 INFO - 'PAGER': '/bin/cat', 19:41:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:16 INFO - 'PWD': '/builds/slave/test', 19:41:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:16 INFO - 'SHELL': '/bin/bash', 19:41:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:16 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:16 INFO - 'USER': 'cltbld', 19:41:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:16 INFO - 'XPC_FLAGS': '0x0', 19:41:16 INFO - 'XPC_SERVICE_NAME': '0', 19:41:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ty6ZtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-YovyfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-DqN80l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-IS6v9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-KIsfPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-dZCbcL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-r5HkGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:41:17 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-4CkKzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Wk0kPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-zCoUVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-dwU2mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-9qwVzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-VmfLt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-OM99HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-VippgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-7JCC1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:41:18 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-0JhVaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:41:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:41:18 INFO - Running setup.py install for manifestparser 19:41:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:41:19 INFO - Running setup.py install for mozcrash 19:41:19 INFO - Running setup.py install for mozdebug 19:41:19 INFO - Running setup.py install for mozdevice 19:41:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:41:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:41:19 INFO - Running setup.py install for mozfile 19:41:19 INFO - Running setup.py install for mozhttpd 19:41:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:41:19 INFO - Running setup.py install for mozinfo 19:41:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:41:19 INFO - Running setup.py install for mozInstall 19:41:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Running setup.py install for mozleak 19:41:20 INFO - Running setup.py install for mozlog 19:41:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Running setup.py install for moznetwork 19:41:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Running setup.py install for mozprocess 19:41:20 INFO - Running setup.py install for mozprofile 19:41:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:41:20 INFO - Running setup.py install for mozrunner 19:41:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:41:21 INFO - Running setup.py install for mozscreenshot 19:41:21 INFO - Running setup.py install for moztest 19:41:21 INFO - Running setup.py install for mozversion 19:41:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:41:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:41:21 INFO - Cleaning up... 19:41:21 INFO - Return code: 0 19:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:21 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 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:21 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 19:41:21 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 19:41:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:21 INFO - 'HOME': '/Users/cltbld', 19:41:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:21 INFO - 'LOGNAME': 'cltbld', 19:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:21 INFO - 'MOZ_NO_REMOTE': '1', 19:41:21 INFO - 'NO_EM_RESTART': '1', 19:41:21 INFO - 'PAGER': '/bin/cat', 19:41:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:21 INFO - 'PWD': '/builds/slave/test', 19:41:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:21 INFO - 'SHELL': '/bin/bash', 19:41:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:21 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:21 INFO - 'USER': 'cltbld', 19:41:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:21 INFO - 'XPC_FLAGS': '0x0', 19:41:21 INFO - 'XPC_SERVICE_NAME': '0', 19:41:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:41:21 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-R5f0y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:41:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:41:21 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-4JUK9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-KHMC48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-yI0rDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-1ZAB1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-yYuORZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-KNGKgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-yp5cQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-Mg5sSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:41:22 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)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-ctWaPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-4XI00f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:41:22 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-OHgX0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:41:23 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)) 19:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:41:23 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-WRjbGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:41:23 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)) 19:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:41:23 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-KF5yvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:41:23 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)) 19:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:23 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-TiBOYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:41:23 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)) 19:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:41:23 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-90W5h1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:41:23 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)) 19:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:41:23 INFO - Running setup.py (path:/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/pip-nleP8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:41:23 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)) 19:41:23 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)) 19:41:23 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)) 19:41:23 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)) 19:41:23 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)) 19:41:23 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)) 19:41:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:41:23 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 19:41:23 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 19:41:23 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 19:41:23 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 19:41:23 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 19:41:23 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 19:41:26 INFO - Downloading blessings-1.6.tar.gz 19:41:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:41:26 INFO - Installing collected packages: blessings 19:41:26 INFO - Running setup.py install for blessings 19:41:26 INFO - Successfully installed blessings 19:41:26 INFO - Cleaning up... 19:41:26 INFO - Return code: 0 19:41:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:41:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:41:26 INFO - Reading from file tmpfile_stdout 19:41:26 INFO - Current package versions: 19:41:26 INFO - blessings == 1.6 19:41:26 INFO - blobuploader == 1.2.4 19:41:26 INFO - docopt == 0.6.1 19:41:26 INFO - functools32 == 3.2.3-2 19:41:26 INFO - jsonschema == 2.5.1 19:41:26 INFO - manifestparser == 1.1 19:41:26 INFO - mozInstall == 1.12 19:41:26 INFO - mozcrash == 0.17 19:41:26 INFO - mozdebug == 0.1 19:41:26 INFO - mozdevice == 0.48 19:41:26 INFO - mozfile == 1.2 19:41:26 INFO - mozhttpd == 0.7 19:41:26 INFO - mozinfo == 0.9 19:41:26 INFO - mozleak == 0.1 19:41:26 INFO - mozlog == 3.2 19:41:26 INFO - moznetwork == 0.27 19:41:26 INFO - mozprocess == 0.23 19:41:26 INFO - mozprofile == 0.28 19:41:26 INFO - mozrunner == 6.12 19:41:26 INFO - mozscreenshot == 0.1 19:41:26 INFO - mozsystemmonitor == 0.3 19:41:26 INFO - moztest == 0.7 19:41:26 INFO - mozversion == 1.4 19:41:26 INFO - psutil == 3.1.1 19:41:26 INFO - requests == 1.2.3 19:41:26 INFO - wsgiref == 0.1.2 19:41:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:41:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:26 INFO - 'HOME': '/Users/cltbld', 19:41:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:26 INFO - 'LOGNAME': 'cltbld', 19:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:26 INFO - 'MOZ_NO_REMOTE': '1', 19:41:26 INFO - 'NO_EM_RESTART': '1', 19:41:26 INFO - 'PAGER': '/bin/cat', 19:41:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:26 INFO - 'PWD': '/builds/slave/test', 19:41:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:26 INFO - 'SHELL': '/bin/bash', 19:41:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:26 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:26 INFO - 'USER': 'cltbld', 19:41:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:26 INFO - 'XPC_FLAGS': '0x0', 19:41:26 INFO - 'XPC_SERVICE_NAME': '0', 19:41:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:41:26 INFO - Cleaning up... 19:41:26 INFO - Return code: 0 19:41:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:41:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ab93a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac28618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb229c9dd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, '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.OPLIdiP2YT/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.pufd3dBZqm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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 19:41:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:41:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:41:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:41:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:41:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:41:26 INFO - 'HOME': '/Users/cltbld', 19:41:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:41:26 INFO - 'LOGNAME': 'cltbld', 19:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:41:26 INFO - 'MOZ_NO_REMOTE': '1', 19:41:26 INFO - 'NO_EM_RESTART': '1', 19:41:26 INFO - 'PAGER': '/bin/cat', 19:41:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:41:26 INFO - 'PWD': '/builds/slave/test', 19:41:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:41:26 INFO - 'SHELL': '/bin/bash', 19:41:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:41:26 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:41:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:41:26 INFO - 'USER': 'cltbld', 19:41:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:41:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:41:26 INFO - 'XPC_FLAGS': '0x0', 19:41:26 INFO - 'XPC_SERVICE_NAME': '0', 19:41:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:41:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:41:27 INFO - Cleaning up... 19:41:27 INFO - Return code: 0 19:41:27 INFO - Running post-action listener: _resource_record_post_action 19:41:27 INFO - Running post-action listener: _start_resource_monitoring 19:41:27 INFO - Starting resource monitoring. 19:41:27 INFO - ##### 19:41:27 INFO - ##### Finished create-virtualenv step (success) 19:41:27 INFO - ##### 19:41:27 INFO - ##### 19:41:27 INFO - ##### Running install step. 19:41:27 INFO - ##### 19:41:27 INFO - Running pre-action listener: _resource_record_pre_action 19:41:27 INFO - Running main action method: install 19:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:41:27 INFO - Reading from file tmpfile_stdout 19:41:27 INFO - Detecting whether we're running mozinstall >=1.0... 19:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:41:27 INFO - Reading from file tmpfile_stdout 19:41:27 INFO - Output received: 19:41:27 INFO - Usage: mozinstall [options] installer 19:41:27 INFO - Options: 19:41:27 INFO - -h, --help show this help message and exit 19:41:27 INFO - -d DEST, --destination=DEST 19:41:27 INFO - Directory to install application into. [default: 19:41:27 INFO - "/builds/slave/test"] 19:41:27 INFO - --app=APP Application being installed. [default: firefox] 19:41:27 INFO - mkdir: /builds/slave/test/build/application 19:41:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:41:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:42:02 INFO - Reading from file tmpfile_stdout 19:42:02 INFO - Output received: 19:42:02 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:42:02 INFO - Running post-action listener: _resource_record_post_action 19:42:02 INFO - ##### 19:42:02 INFO - ##### Finished install step (success) 19:42:02 INFO - ##### 19:42:02 INFO - ##### 19:42:02 INFO - ##### Running run-tests step. 19:42:02 INFO - ##### 19:42:02 INFO - Running pre-action listener: _resource_record_pre_action 19:42:02 INFO - Running main action method: run_tests 19:42:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:42:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:42:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:42:02 INFO - 2016-07-07 19:42:02.099 screenresolution[1639:7651] starting screenresolution argv=screenresolution get 19:42:02 INFO - 2016-07-07 19:42:02.102 screenresolution[1639:7651] Display 0: 1600x1200x32@60 19:42:02 INFO - 2016-07-07 19:42:02.107 screenresolution[1640:7653] starting screenresolution argv=screenresolution list 19:42:02 INFO - Available Modes on Display 0 19:42:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:42:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:42:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:42:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:42:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:42:02 INFO - Intel Iris: 19:42:02 INFO - Chipset Model: Intel Iris 19:42:02 INFO - Type: GPU 19:42:02 INFO - Bus: Built-In 19:42:02 INFO - VRAM (Dynamic, Max): 1536 MB 19:42:02 INFO - Vendor: Intel (0x8086) 19:42:02 INFO - Device ID: 0x0a2e 19:42:02 INFO - Revision ID: 0x0009 19:42:02 INFO - Displays: 19:42:02 INFO - Display: 19:42:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:42:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:42:02 INFO - Display Serial Number: 1600x1200 60 19:42:02 INFO - Main Display: Yes 19:42:02 INFO - Mirror: Off 19:42:02 INFO - Online: Yes 19:42:02 INFO - Rotation: Supported 19:42:02 INFO - Return code: 0 19:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:42:02 INFO - Python 2.7.3 19:42:02 INFO - Return code: 0 19:42:02 INFO - grabbing minidump binary from tooltool 19:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:42:02 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 0x10aaf7d30>, '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 0x10a85cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10aaefb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:42:02 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 19:42:02 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 19:42:02 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 19:42:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:42:02 INFO - Return code: 0 19:42:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:42:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:42:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:42:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:42:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:42:02 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/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 19:42:02 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/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0247 --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 19:42:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OPLIdiP2YT/Render', 19:42:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:02 INFO - 'HOME': '/Users/cltbld', 19:42:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:02 INFO - 'LOGNAME': 'cltbld', 19:42:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:42:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:02 INFO - 'MOZ_NO_REMOTE': '1', 19:42:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:42:02 INFO - 'NO_EM_RESTART': '1', 19:42:02 INFO - 'PAGER': '/bin/cat', 19:42:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:02 INFO - 'PWD': '/builds/slave/test', 19:42:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:42:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:02 INFO - 'SHELL': '/bin/bash', 19:42:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pufd3dBZqm/Listeners', 19:42:02 INFO - 'TMPDIR': '/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/', 19:42:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:02 INFO - 'USER': 'cltbld', 19:42:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:02 INFO - 'XPC_FLAGS': '0x0', 19:42:02 INFO - 'XPC_SERVICE_NAME': '0', 19:42:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:02 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/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0247', '--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 19:42:02 INFO - mozversion application_buildid: 20160707173727 19:42:02 INFO - mozversion application_changeset: 89cae7a45e2388ea0079f9570eadfd538cd98930 19:42:02 INFO - mozversion application_display_name: Nightly 19:42:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:42:02 INFO - mozversion application_name: Firefox 19:42:02 INFO - mozversion application_remotingname: firefox 19:42:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:42:02 INFO - mozversion application_vendor: Mozilla 19:42:02 INFO - mozversion application_version: 50.0a1 19:42:02 INFO - mozversion platform_buildid: 20160707173727 19:42:02 INFO - mozversion platform_changeset: 89cae7a45e2388ea0079f9570eadfd538cd98930 19:42:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:42:02 INFO - mozversion platform_version: 50.0a1 19:42:02 INFO - using testdate: 1467945722 19:42:02 INFO - actual date: 1467945722 19:42:02 INFO - starting webserver on 'localhost:49280' 19:42:02 INFO - SUITE-START | Running 2 tests 19:42:02 INFO - TEST-START | dromaeo_css 19:42:02 INFO - operating with platform_type : mac_ 19:42:02 INFO - Initialising browser for dromaeo_css test... 19:42:02 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpwcvGhP/profile http://localhost:49280/getInfo.html) 19:42:04 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:42:04 INFO - PROCESS | 1650 | colorDepth:24 19:42:04 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:42:04 INFO - PROCESS | 1650 | __metrics 19:42:05 INFO - PROCESS | 1650 | 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" 19:42:05 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:42:05 INFO - TEST-INFO | 1650: exit 0 19:42:05 INFO - Browser initialized. 19:42:05 INFO - Running cycle 1/1 for dromaeo_css test... 19:42:05 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpwcvGhP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:42:17 INFO - PROCESS | 1652 | RSS: Main: 243720192 19:42:17 INFO - PROCESS | 1652 | 19:43:09 INFO - PROCESS | 1652 | 1467945789209 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] 19:45:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 19:45:21 INFO - PROCESS | 1652 | RSS: Main: 379924480 19:45:21 INFO - PROCESS | 1652 | 19:48:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 19:48:24 INFO - PROCESS | 1652 | RSS: Main: 375128064 19:48:24 INFO - PROCESS | 1652 | 19:51:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 19:51:27 INFO - PROCESS | 1652 | RSS: Main: 370900992 19:51:27 INFO - PROCESS | 1652 | 19:54:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 19:54:30 INFO - PROCESS | 1652 | RSS: Main: 373981184 19:54:30 INFO - PROCESS | 1652 | 19:57:33 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 19:57:34 INFO - PROCESS | 1652 | RSS: Main: 343867392 19:57:34 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 20:00:37 INFO - PROCESS | 1652 | RSS: Main: 426471424 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | __start_tp_report 20:00:37 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 20:00:37 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 20:00:37 INFO - PROCESS | 1652 | |i|pagename|runs| 20:00:37 INFO - PROCESS | 1652 | |0;dojo.html;3162.367526494701;3350.7654464187517;3363.8822641207553;3381.6956473917344;3405.71051460626;5582.9950608890385;5609.83170504885;5642.069058605335;5693.174489698997;5745.971270143648;5669;5685.829425117253;5792.6524408535415;5809.651420914748;5828.591998560102;5117;5119.974400128012;5183.50756678115;5195.506426889439;5279.841604751864;5244.344456942882;5315.760790764425;5319;5325.360956685203;5359.651622644536;5125.564327032188;5161.27742116104;5169.4572069932865;5173.456787037382;5180.922286165692;5157.896842063175;5180.559652429548;5187.974060129675;5201.843944681666;5201.8959620807755;4744.810207591692;5164.6384753067305;5182.067227898977;5216.295800067019;5230.08473517133;5582.218489411485;5591.2731344925305;5722.914156287659;5724;5800.361960184377;6243.094751261087;6252.5935814171935;6266.49868010558;6266.905996410058;6274.811755647338;6242;6299.779507717208;6304.873902521924;6307.306196318401;6308.684565771739;4893.902121957576;5667.433256674341;5743.54051675865;5830.2420685310635;5862.97068514659;6261.7182226799905;6279.3720627937755;6280.2777680566405;6281.623102613858;6286.277078136073;6154.630722156685;6173.9073913891325;6177.042558403455;6185.721642526097;6188.721507532172;6042.879142417127;6123.221615589998;6144.723487443076;6205;6263.467605253513;6188.81433556994;6214.1921550198185;6227.283862355796;6240.781572644935;6272.184615999982;5122.231665250168;6221.4089661482085;6244.125822384779;6249.593776404519;6264.655443950626;4128.2156390285745;4888;4895.534924182197;4924.8768780780765;4954.984228233204;3729.4219395993664;4429.357743127229;4488;4488;4491.618212451913;5740.913886291709;5753.453421924911;5813.040848260074;5821.854453638693;5822.417758224228;6132.355508992456;6142.6314421134875;6143.170671959318;6144.139820425144;6159.784407545804;5742.28221472316;5757.798477053283;5792.131180322901;5818.796342128006;5849.502792262705;5379.112446446371;5403.297571315704;5404.243405923174;5406.756695948613;5412.56699464042;6193.225846769154;6250.062490626351;6285.182926219653;6307;6307.653079080695;5459.535939445032;6193.628382297076;6206.255249370104;6212.192414986203;6234.1583886174785;6297.307296197506;6321.589096708699;6334.334894835976;6342.619442833445;6370.203724534434;5086.847394578169;6058.666773327509;6130.917941862889;6133.938660613337;6174.289956655042;4906.730129842893;4910.803567857389;5228.320318358741;6269.5611307208055;6275.403836635513;6096.817095487142;6124.663143527148;6136.018237082046;6143.815685529441;6144.508439324933;5928.081147422156;6005.219321488354;6031.215941927521;6095.05526643371;6113.052476866093;5956.642601443928;5980.43185897339;5988.730507127103;5991.3409524953095;6006.249218847644;5087.745612719424;6094.481969032682;6119.204503414528;6131.96934015327;6132.448079672851;5742.913856292075;5812.389699081536;5852.18069470266;5902.881942361215;5909.3795151508475 20:00:37 INFO - PROCESS | 1652 | |1;ext.html;442.6480947646621;478.2300496201118;484.18173287144725;519.3041324625002;525.3616855520544;31448.842755786216;42505.78747106264;43260.78369608152;43386.7830660847;43426.697199084076;36428.453573196355;44803;45097.549024509746;45110;45267.77366113173;8766.56167191641;9518.048195180478;9695.70912872615;9696.854547181763;9714.562844671971;8751.737447876541;8984.10158984103;9000.684976025841;9014;11665.066794656406;11711.882881171206;12025.639230823046;12049.879501204963;12062;12072.215306005126;11890.821637675399;11970.341631210324;11980.70048248792;11986.820197697041;12015.519379224821;8752.387332886701;11522.654320370319;11812.350320732356;11813.291202527877;11842.407879605986;37670;38757.41863872044;42033.57966420327;42343.36484952728;42447.78776106131;3326.4012477753995;3494.3884820156372;3577.0878426001464;3614.710823134143;3703.8148092595534;31736.04791856248;32116.518252226237;32483.863064792855;33145;33348.3330333392;2779.5691667791525;3279.5244689520123;3284.8850290239725;3321.5183798349344;3420.675035871588;536172;537458.6254137487;539793.3010334963;539806;542226;60624.39375606276;61299.69350153221;61411.69294153501;61526.69236653788;61605;65010.67494662591;65196;65256;65305.67347163234;65317;16187.271572779253;16709.498715038568;16714.498565042824;16739.66520669604;16741.832581674273;12946.223226606433;13030.283334416508;13037.869621303855;13059.934700326437;13065.346732663329;12998.675033124058;14181.936354773226;14469.914756393102;15768.369265229263;15995.680086398206;6717.865642687118;6746.966265168643;6747.426468750211;6810;6817.216020157646;816.1960468938091;918.1277786103228;966.9903300966901;983.2920297385871;989.4211886046743;25671.614925776128;30841.383172336427;30976.53535196974;31167.90912318058;31474;1034.896510348974;1127.8026345389524;1205.7588482303574;1207.9516819327127;1217.2088142707312;15992.76010859838;16071.919640401724;16173;16326.713498389547;16475.704859028243;687638;689859;690446;690481;691570;60745.69627151836;61584.38415615876;61734.765304693654;61843.38156618466;62005.68997154985;1270.4092596942282;1309.5612969655272;1408.4155075643698;1418.9574312770633;1435.7128574285184;23681.52636947286;26417.867910661094;27869.860650696617;31729.365412692077;32530.02409927706;50888.236676449145;51433.74283128561;51682.48317516777;51945.740271298404;51973.480265196864;466607;495317;502096;503045;505388;34698;39378.80310598428;40599.797001014806;40640.59359406368;40809.59190408058;36982.815085925475;44569.81942064966;48761.2685809706;51637;52910.47089529209;39791.60208397879;41033.97415064647;41412;41469.377959331236;42292;33065.834670826494;40299;40959.38560921648;41176.58823411728;41351.58648413477;38022.049448764;38714.22571548497;38889.833305000895;39156;39361;27961.720382796724;30282.637281322834;32583.837080814443;35369;35563;22845.65731514062;25646;26063.348416288987;26219.21342359732;26573.468530629667 20:00:37 INFO - PROCESS | 1652 | |2;jquery.html;376.4992559895339;387.103854576655;389.2526349409134;399.30520893645064;400.31745873286053;19614.019299035044;21251.362459126212;22107.66838497422;22144.557108857814;22391;21895.452613684625;22044.779552204473;22164.556708865854;22409.55180896381;22416.215432459867;4378.846740364096;5617.241672374238;5618.353889302742;5665.54675625951;5673.205751194836;3995.8601448949294;4234.978825105885;5584.078627026556;5691.630044047124;5934.228550288456;5467.617266791326;6220.1602783624085;6266.811995640138;6276.121343011982;6290.559660823744;6263.248410190783;6470.870582588345;6839.487038472134;6843.281455447156;6863.656817159172;3813.0848596336955;4029;4143.6685065194715;6081.695915204222;6088.4215999479975;13158.14472059313;13582.117162384413;13714.862851371458;13723.176609403468;13745.587632371045;2157.1479265689964;2290.278562252885;2356.104680221522;2358.657994590792;2378.6907701998803;9881.25890558211;9964.455509396055;10142.087212150942;10590.09984151348;10651.094656954168;1887.962240755191;1939.0111043367983;1954.775200851892;1987.930422435208;1991.790861959488;117575.41212293884;123568;123904.38047809704;125499.37250313781;127206;9546.665866694633;11550.249233799945;11586.246893951866;11662.60916512113;11830.645080647595;14742.410303587736;14828.3327250274;14837.035592686441;14854.702905942037;14856.18290993984;8595.398322117517;8778.473291602397;8809.559522023874;8868.822623547621;8916.242119419792;8745.737627871047;8769.561521923879;8814.030456649763;8919.375643705009;8926.598303076376;4554.476235232924;4628.236341003697;4636.304554316812;4693.78877950493;4695.5539223773685;1773.9024353660673;1837.5865430278348;1878.840298574609;1930.7779605345283;1958.2265005322818;949.5424523356614;949.7198326493701;974.6588693957058;981.7349315684725;984.7735020945223;21848.563028739336;21974.01116949741;22041;22051.66922496164;22063.448413789785;976.7460460280379;985.9014098590227;1007.1992765751245;1021.5198856537415;1025.9487025648837;10941.179411544166;11443.485043173077;11487.023602993671;11499.022583080365;11529.423528823692;515647;521532;523468;581942;612093;123355;124335;136818;140727;146403;439.98680039598224;443.09608398865953;462.88196509890435;463.9257718764981;464.72116729961755;11177.752454067402;11255.831162532731;11459;11684.88315116872;11938.522459101887;58307;58742.41257587369;59731.70134149301;60011.09983350341;60256.69871650789;83707.16292836994;84028.15971840204;84101.57949210214;84781.57609211914;86523.56738216268;7959.4030447715495;8034.236747508978;8128.14654461273;8361.122082181284;8365.95817020911;11697.941510292394;12412.441440135035;12501.374931253218;12657.177283476545;12692.238465692088;10893.673189804318;11105.888941110485;11144.164187685794;11177.385243811668;11184.496697648789;4997.5002499749735;7443.776686699408;9071.546422678972;10775.47024683581;10971.01260886524;9794.54401883219;10437.58249670035;11242.213045086766;11435.142364322543;11685.707857303636;8355.582220889053;8367.539785311867;8379.95810020946;8404.621792019252;8669.263112635497;5512.283403157564;10565.366078035342;10974.231803773979;11094.779574246664;11274 20:00:37 INFO - PROCESS | 1652 | |3;mootools.html;1572.9449469268575;1579.928903199356;1791.9552011199726;1920.1167462967035;1928.8456923446126;8730.519821409827;9060.773480662987;9225.723228303144;9228.307876909243;9236.67671631493;7987;8225.753227403187;8684.478931264128;8917.73246802597;9036.50299233542;2361.822863285256;2386.498835244592;2388.4984153327823;2392.28231530541;2394.5450364430703;2372.217168334454;2375.429896824758;2419.8064154867657;2419.8911049002836;2421.5883299838983;2095.067694875781;2180.8800515971616;2182.8253739700867;2183.410479170623;2184.7050648162535;2312.329424466911;2383.845050071757;2388.9641655375185;2389.450426401929;2390.581648211556;2377.976220237793;2396.508715713275;2401.3156250468705;2406.2420337593776;2412.276317104879;9148.8627670585;9221.90778092224;9226.677066302715;9231.584578693975;9262.490563019099;5324.41431442541;5445.754941027663;5492.505674489315;5496.725163741797;5501.972490137524;3561.554805649294;3614.8554057837655;3665.871694490707;3683.3001729671278;3689.631036896316;1047.3297089862494;1071.560660129351;1095.2278643556353;1113.1651261553834;1114.587602587048;12187.695307617292;12216.083793715507;12233.694157646041;12238.938805306005;12296.446659900326;4732.574068333866;4738.431388233365;4849.684770489906;4886.511348865085;4899.706017638881;10189.337693049929;10299.330543514647;10332.845007324897;10350.378977261238;10351.896481035245;5473.589480788957;5479.589030822704;5491.560675145979;5503.779848806083;5509.311336082989;4831.299461578052;4998.300237966688;5002.499750024968;5025.7989680412375;5028.969061342416;3946.644801967779;3950.150717595731;4034.092329225901;4040;4077.1234184650443;1258.7797135501435;1288.1240756285629;1296.2222666400085;1301.3883474766844;1311.1543054729646;827.6192951242496;935.9625614975461;945.6217512994857;985.103555764251;985.4284514981437;6162;6224.097505861625;6278.780242691484;6284.780032698834;6289.905651415233;440.89418539550275;456.18798538601345;463.0391936731229;952.5999080386255;1037.2169012395743;4138.482689663792;4188.246115699142;4193.958060419418;4263.509696384894;4263.637590804754;11057;11197;11231;11322.37726925027;11330.886691132982;11273.887261127284;11287.943560282147;11293.71765705864;11300.152488563226;11301.039411650101;8025.117237103797;8436.28291595209;8571.699990500303;8572.442791218551;8589.14108589136;6061.787837425669;6148.1085242640465;6206.72069756871;6222.751089956351;6236.844078898064;10249.282550221413;10326.277160598986;10331.380117192692;10348.844767328346;10382.117520010883;9899.406035637885;10343.482825858526;10560.577576896838;10574.471276436301;10588.629397971034;7674.424418168548;7729.4202934779;7834.608269586612;7837.294643482114;7871.134175240604;8354.331653467829;8472.61873215719;8550.700725474579;8554.059053503985;8611.569421528773;7574.091109066947;7648.273414025659;7660.885086723592;7716.807079823049;7803.960980195063;7412.740554080581;7465.738699145504;7481.251874812475;7618.961905190438;7638.465307428427;6932.6533673315125;7089.936509523613;7139.286071392819;7166.749163779243;7186.353228209487;4638.721676699409;4945.975270123627;5006.74831292177;5091.236314552847;5154.1237989542615;4643.233866412139;5182.948170518397;5199.4540573239265;5229.712365819916;5345.091334473072 20:00:37 INFO - PROCESS | 1652 | |4;prototype.html;305.61034680782;311.5762562914436;315.8878598097675;319.3517160164866;322.74825636003897;5434.72826358682;5436.015854213213;5448.891022179554;5468.261784659075;5505.394406615269;4674.789634466449;5087.049511283456;5391;5392.406835248129;5421.292292927725;3582.6775590196876;3922.509686289221;3951.841926322958;4059.04612416082;4174.538911381022;4078.796060196993;4121.7634709587155;4126.587341265865;4146.9792651036705;4147.771872547009;4109.363048727452;4111.177764447108;4122.9381559276635;4141.420201171838;4149.937750933738;3033.924151896198;3579.3736096183065;3815.4276858471176;4027.2952233359047;4130.380442933554;3546.609872914003;3580.7135429165605;3581.6955558777536;3592.263585964871;3592.3533763922483;5320.733963301819;5333.4399888011585;5358.598105142091;5361.900810333872;5370.91943620846;4555.293929440909;4800.783964721596;4826.951730482685;4836.904381196037;4855.951440485585;4697.812087516495;5681.528535087209;5687.090065589486;5722.170285308607;5730.656160630376;3796.822984874698;3969.503812023497;3997.8200980955635;4002.239574480839;4006.939895901564;5431.918521222185;5485.189887337169;5693.459121383504;5856.677882716449;5890.352061273256;4018.517777866675;4020.8994775130855;4031.23406552754;4055.3308704063497;4082.3672330788777;4082.3672330788777;4132.285101682768;4143;4144.44050053245;4148.460700109027;4635.502154606029;4683.344331793552;4730.219513780256;4785.665003449794;4799.28010798383;5066.544011039025;5489.890202196014;5645.717714114277;5763.7982670606325;5765.848589015902;1160.843286156375;1208.6374087773634;1240.8212198411545;1395.1838174667932;1400.9649758755909;786.0057027859762;849.4096602860952;849.8017794909149;880.823835232956;884.9867251991225;4305.827766889352;4576.8626941191815;4843.055604157226;4844.224924012141;5125.56432703217;5839.817299571659;5906;5913.319968203712;5920.5559583031445;5923.733431995571;4257.914231870853;4731.4795372509;4784.162771514971;5294.41761406245;5311.787528498817;2847.6933683716256;2903.724146206107;3081.3683194944983;3092.6443459002053;3094.659587445379;4796.616270698336;5140.460251673595;5989.580729348903;6095.8910955412175;6117.461253579803;5662.462066103796;5962.5826192167;6018.518518518508;6037.732076264034;6072.574919755663;5064.696118232918;5295.232191332235;6032.3967603239325;6120.571559990847;6122.265328160649;5549.724612908688;5799.246098007232;5832.62087964281;5870.970645146747;5882.5293077084725;4863.416390033077;5004.374453193351;5042.798288068583;5568;5815.621984570989;4895.751583346224;5578.86052848682;5820.76716931318;6136.12178318247;6139.201903752483;3755.267722794138;3976.0258736609717;3979.547465175248;3985.262726395626;4012.8194231260245;5257.63196576236;5735.8566035849435;5801.506871915934;5816.883662326645;5853.546407619525;5323.547498462519;5479.4520547944885;5686.374498805211;5688.374278829243;5704.429557044263;5278.89442211146;5316.308879845596;5682.914756278742;5740.799072032459;5770;4900.191468407673;5614.214010038516;5650.378458369494;5660.433956604306;5705.972924873563;5259.763310651107;5465.808696695596;5636.943630563642;5664.289890121977;5665.801696940587;5471.644343117844;5557.944420555743;5569.607598100475;5572.637778544544;5574.693391863487 20:00:37 INFO - PROCESS | 1652 | |5;yui.html;790.7706765038139;809.9878501822471;825.9958700206498;839.7438781171742;855.5636625321092;15496.9926954748;15567.610809729735;16105.27526261321;16199.352025918965;16201.837981620194;14900.40398384066;14956.850431495683;15120.278349897015;15122.924385378084;15207.163606001666;719.4208662027066;735.9300866417682;890.363390176024;894.6645008121955;906.7053207707488;805.2993895311088;917.3853518142827;918.008550765172;918.8024574716435;918.9632414703437;969.2100937735757;975.9609615615367;977.0180968127022;977.2377545514474;979.3291595257236;748.3003391828657;932.2076235200093;973.3770386952356;974.0989584634185;974.8927617962019;720.4920531025614;722.4689852958072;722.7867779005206;722.902408174895;723.1141851232251;15017.174055426947;15060.623484412978;15072.020318679251;15104.697906041927;15111.54665360041;11373.31760094397;13376.464941402332;14002.299885005708;14066.296685165804;14279.21464319462;12604.432800523999;12660.81008784869;12699.301538415384;12768.489260429571;13160.670983225496;4555.881355594104;4603.5166307537565;4673;4722;4785.928211076836;108356;108660.91339086666;108815.36776948352;109119.45440272748;113589.43205283921;10918.1811364148;11002.559897604006;11013.669589912315;11095;11173.720656983478;21748.565028699653;21750.673739893915;21765.455863603536;21827.01778419975;21832.454188645093;7791.883121753178;7849.568273744999;7869.0950540688555;7897.68409263623;8124.390670699603;4405.933910991338;4461.910761784746;4484.596386325246;4596.448426188812;4680.204365257914;2948.2187220386613;3607.494950706903;3609.530761001053;3609.9639003609627;3626.5648122225502;553.5891758059746;589.7876764364826;590.8168467775004;625.8748250349948;633.7940169444948;534.636447215897;670.661316035399;687.5591649643744;690.5649440852231;722.1868534139751;8805.735827925173;9570.282228832726;9572.946975832652;9602.183814375856;9952.118852642361;589.0104624231333;632.6172665537375;662.8475450646379;680.8638272345551;686.6257889450262;4628.652851036119;4732.73969931657;4751.382320298409;4752.310914917318;4822.421309442819;91092.54453727689;135913.3204333972;142538;149698;152944;108502.45748771206;109731.45134274277;111199;123865;131337.34331328282;92621.07378926124;109591;110203;116028;117114.41442792732;9535.38020028696;9875;10143.594256229668;10307.793844123225;10311.948440257751;56782;64818;66527.66736166288;67069;69647.65176174087;100796;101067.49466252622;102784;102896.48551757193;103591;13395.330233488092;13558.86441135576;13561.660958476117;13872.306384680927;14142.434302628191;15041.323140458488;15142.772858407354;15320.080795152326;15555.533333999998;15610;8803.647854085764;13393.66515837112;14137.646558836112;14388.909807963;14752.852471475147;14102.929485352508;14150.504732334319;14372.784408233676;14388.35252413623;14623.268836558342;13345;13952.511662091778;14040.438382464587;14179.078359906573;14200.502982395567;10918.563257469612;11055.72360690989;11065.514507531698;11066.944665276622;11315.886841131813;10973.451327433437;11017.724556886142;11735.647930562096;11743.941280293544;11788.646340609796 20:00:37 INFO - PROCESS | 1652 | __end_tp_report 20:00:37 INFO - PROCESS | 1652 | __start_cc_report 20:00:37 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,1333 20:00:37 INFO - PROCESS | 1652 | __end_cc_report 20:00:37 INFO - PROCESS | 1652 | __startTimestamp1467946837838__endTimestamp 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | ------- Summary: start ------- 20:00:37 INFO - PROCESS | 1652 | Number of tests: 6 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5684.96 Median:5849.50 stddev:668.14 (11.4%) stddev-sans-first:640.21 20:00:37 INFO - PROCESS | 1652 | Values: 3162.4 3350.8 3363.9 3381.7 3405.7 5583.0 5609.8 5642.1 5693.2 5746.0 5669.0 5685.8 5792.7 5809.7 5828.6 5117.0 5120.0 5183.5 5195.5 5279.8 5244.3 5315.8 5319.0 5325.4 5359.7 5125.6 5161.3 5169.5 5173.5 5180.9 5157.9 5180.6 5188.0 5201.8 5201.9 4744.8 5164.6 5182.1 5216.3 5230.1 5582.2 5591.3 5722.9 5724.0 5800.4 6243.1 6252.6 6266.5 6266.9 6274.8 6242.0 6299.8 6304.9 6307.3 6308.7 4893.9 5667.4 5743.5 5830.2 5863.0 6261.7 6279.4 6280.3 6281.6 6286.3 6154.6 6173.9 6177.0 6185.7 6188.7 6042.9 6123.2 6144.7 6205.0 6263.5 6188.8 6214.2 6227.3 6240.8 6272.2 5122.2 6221.4 6244.1 6249.6 6264.7 4128.2 4888.0 4895.5 4924.9 4955.0 3729.4 4429.4 4488.0 4488.0 4491.6 5740.9 5753.5 5813.0 5821.9 5822.4 6132.4 6142.6 6143.2 6144.1 6159.8 5742.3 5757.8 5792.1 5818.8 5849.5 5379.1 5403.3 5404.2 5406.8 5412.6 6193.2 6250.1 6285.2 6307.0 6307.7 5459.5 6193.6 6206.3 6212.2 6234.2 6297.3 6321.6 6334.3 6342.6 6370.2 5086.8 6058.7 6130.9 6133.9 6174.3 4906.7 4910.8 5228.3 6269.6 6275.4 6096.8 6124.7 6136.0 6143.8 6144.5 5928.1 6005.2 6031.2 6095.1 6113.1 5956.6 5980.4 5988.7 5991.3 6006.2 5087.7 6094.5 6119.2 6132.0 6132.4 5742.9 5812.4 5852.2 5902.9 5909.4 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:71516.49 Median:39258.50 stddev:155140.74 (395.2%) stddev-sans-first:155484.18 20:00:37 INFO - PROCESS | 1652 | Values: 442.6 478.2 484.2 519.3 525.4 31448.8 42505.8 43260.8 43386.8 43426.7 36428.5 44803.0 45097.5 45110.0 45267.8 8766.6 9518.0 9695.7 9696.9 9714.6 8751.7 8984.1 9000.7 9014.0 11665.1 11711.9 12025.6 12049.9 12062.0 12072.2 11890.8 11970.3 11980.7 11986.8 12015.5 8752.4 11522.7 11812.4 11813.3 11842.4 37670.0 38757.4 42033.6 42343.4 42447.8 3326.4 3494.4 3577.1 3614.7 3703.8 31736.0 32116.5 32483.9 33145.0 33348.3 2779.6 3279.5 3284.9 3321.5 3420.7 536172.0 537458.6 539793.3 539806.0 542226.0 60624.4 61299.7 61411.7 61526.7 61605.0 65010.7 65196.0 65256.0 65305.7 65317.0 16187.3 16709.5 16714.5 16739.7 16741.8 12946.2 13030.3 13037.9 13059.9 13065.3 12998.7 14181.9 14469.9 15768.4 15995.7 6717.9 6747.0 6747.4 6810.0 6817.2 816.2 918.1 967.0 983.3 989.4 25671.6 30841.4 30976.5 31167.9 31474.0 1034.9 1127.8 1205.8 1208.0 1217.2 15992.8 16071.9 16173.0 16326.7 16475.7 687638.0 689859.0 690446.0 690481.0 691570.0 60745.7 61584.4 61734.8 61843.4 62005.7 1270.4 1309.6 1408.4 1419.0 1435.7 23681.5 26417.9 27869.9 31729.4 32530.0 50888.2 51433.7 51682.5 51945.7 51973.5 466607.0 495317.0 502096.0 503045.0 505388.0 34698.0 39378.8 40599.8 40640.6 40809.6 36982.8 44569.8 48761.3 51637.0 52910.5 39791.6 41034.0 41412.0 41469.4 42292.0 33065.8 40299.0 40959.4 41176.6 41351.6 38022.0 38714.2 38889.8 39156.0 39361.0 27961.7 30282.6 32583.8 35369.0 35563.0 22845.7 25646.0 26063.3 26219.2 26573.5 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33893.25 Median:2094.79 stddev:93233.75 (4450.7%) stddev-sans-first:93461.33 20:00:37 INFO - PROCESS | 1652 | Values: 376.5 387.1 389.3 399.3 400.3 19614.0 21251.4 22107.7 22144.6 22391.0 21895.5 22044.8 22164.6 22409.6 22416.2 4378.8 5617.2 5618.4 5665.5 5673.2 3995.9 4235.0 5584.1 5691.6 5934.2 5467.6 6220.2 6266.8 6276.1 6290.6 6263.2 6470.9 6839.5 6843.3 6863.7 3813.1 4029.0 4143.7 6081.7 6088.4 13158.1 13582.1 13714.9 13723.2 13745.6 2157.1 2290.3 2356.1 2358.7 2378.7 9881.3 9964.5 10142.1 10590.1 10651.1 1888.0 1939.0 1954.8 1987.9 1991.8 117575.4 123568.0 123904.4 125499.4 127206.0 9546.7 11550.2 11586.2 11662.6 11830.6 14742.4 14828.3 14837.0 14854.7 14856.2 8595.4 8778.5 8809.6 8868.8 8916.2 8745.7 8769.6 8814.0 8919.4 8926.6 4554.5 4628.2 4636.3 4693.8 4695.6 1773.9 1837.6 1878.8 1930.8 1958.2 949.5 949.7 974.7 981.7 984.8 21848.6 21974.0 22041.0 22051.7 22063.4 976.7 985.9 1007.2 1021.5 1025.9 10941.2 11443.5 11487.0 11499.0 11529.4 515647.0 521532.0 523468.0 581942.0 612093.0 123355.0 124335.0 136818.0 140727.0 146403.0 440.0 443.1 462.9 463.9 464.7 11177.8 11255.8 11459.0 11684.9 11938.5 58307.0 58742.4 59731.7 60011.1 60256.7 83707.2 84028.2 84101.6 84781.6 86523.6 7959.4 8034.2 8128.1 8361.1 8366.0 11697.9 12412.4 12501.4 12657.2 12692.2 10893.7 11105.9 11144.2 11177.4 11184.5 4997.5 7443.8 9071.5 10775.5 10971.0 9794.5 10437.6 11242.2 11435.1 11685.7 8355.6 8367.5 8380.0 8404.6 8669.3 5512.3 10565.4 10974.2 11094.8 11274.0 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5897.00 Median:4735.50 stddev:3351.64 (70.8%) stddev-sans-first:3345.29 20:00:37 INFO - PROCESS | 1652 | Values: 1572.9 1579.9 1792.0 1920.1 1928.8 8730.5 9060.8 9225.7 9228.3 9236.7 7987.0 8225.8 8684.5 8917.7 9036.5 2361.8 2386.5 2388.5 2392.3 2394.5 2372.2 2375.4 2419.8 2419.9 2421.6 2095.1 2180.9 2182.8 2183.4 2184.7 2312.3 2383.8 2389.0 2389.5 2390.6 2378.0 2396.5 2401.3 2406.2 2412.3 9148.9 9221.9 9226.7 9231.6 9262.5 5324.4 5445.8 5492.5 5496.7 5502.0 3561.6 3614.9 3665.9 3683.3 3689.6 1047.3 1071.6 1095.2 1113.2 1114.6 12187.7 12216.1 12233.7 12238.9 12296.4 4732.6 4738.4 4849.7 4886.5 4899.7 10189.3 10299.3 10332.8 10350.4 10351.9 5473.6 5479.6 5491.6 5503.8 5509.3 4831.3 4998.3 5002.5 5025.8 5029.0 3946.6 3950.2 4034.1 4040.0 4077.1 1258.8 1288.1 1296.2 1301.4 1311.2 827.6 936.0 945.6 985.1 985.4 6162.0 6224.1 6278.8 6284.8 6289.9 440.9 456.2 463.0 952.6 1037.2 4138.5 4188.2 4194.0 4263.5 4263.6 11057.0 11197.0 11231.0 11322.4 11330.9 11273.9 11287.9 11293.7 11300.2 11301.0 8025.1 8436.3 8571.7 8572.4 8589.1 6061.8 6148.1 6206.7 6222.8 6236.8 10249.3 10326.3 10331.4 10348.8 10382.1 9899.4 10343.5 10560.6 10574.5 10588.6 7674.4 7729.4 7834.6 7837.3 7871.1 8354.3 8472.6 8550.7 8554.1 8611.6 7574.1 7648.3 7660.9 7716.8 7804.0 7412.7 7465.7 7481.3 7619.0 7638.5 6932.7 7089.9 7139.3 7166.7 7186.4 4638.7 4946.0 5006.7 5091.2 5154.1 4643.2 5182.9 5199.5 5229.7 5345.1 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4617.55 Median:5258.70 stddev:1410.99 (26.8%) stddev-sans-first:1377.33 20:00:37 INFO - PROCESS | 1652 | Values: 305.6 311.6 315.9 319.4 322.7 5434.7 5436.0 5448.9 5468.3 5505.4 4674.8 5087.0 5391.0 5392.4 5421.3 3582.7 3922.5 3951.8 4059.0 4174.5 4078.8 4121.8 4126.6 4147.0 4147.8 4109.4 4111.2 4122.9 4141.4 4149.9 3033.9 3579.4 3815.4 4027.3 4130.4 3546.6 3580.7 3581.7 3592.3 3592.4 5320.7 5333.4 5358.6 5361.9 5370.9 4555.3 4800.8 4827.0 4836.9 4856.0 4697.8 5681.5 5687.1 5722.2 5730.7 3796.8 3969.5 3997.8 4002.2 4006.9 5431.9 5485.2 5693.5 5856.7 5890.4 4018.5 4020.9 4031.2 4055.3 4082.4 4082.4 4132.3 4143.0 4144.4 4148.5 4635.5 4683.3 4730.2 4785.7 4799.3 5066.5 5489.9 5645.7 5763.8 5765.8 1160.8 1208.6 1240.8 1395.2 1401.0 786.0 849.4 849.8 880.8 885.0 4305.8 4576.9 4843.1 4844.2 5125.6 5839.8 5906.0 5913.3 5920.6 5923.7 4257.9 4731.5 4784.2 5294.4 5311.8 2847.7 2903.7 3081.4 3092.6 3094.7 4796.6 5140.5 5989.6 6095.9 6117.5 5662.5 5962.6 6018.5 6037.7 6072.6 5064.7 5295.2 6032.4 6120.6 6122.3 5549.7 5799.2 5832.6 5871.0 5882.5 4863.4 5004.4 5042.8 5568.0 5815.6 4895.8 5578.9 5820.8 6136.1 6139.2 3755.3 3976.0 3979.5 3985.3 4012.8 5257.6 5735.9 5801.5 5816.9 5853.5 5323.5 5479.5 5686.4 5688.4 5704.4 5278.9 5316.3 5682.9 5740.8 5770.0 4900.2 5614.2 5650.4 5660.4 5706.0 5259.8 5465.8 5636.9 5664.3 5665.8 5471.6 5557.9 5569.6 5572.6 5574.7 20:00:37 INFO - PROCESS | 1652 | 20:00:37 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:24647.99 Median:21749.62 stddev:38262.95 (175.9%) stddev-sans-first:38328.36 20:00:37 INFO - PROCESS | 1652 | Values: 790.8 810.0 826.0 839.7 855.6 15497.0 15567.6 16105.3 16199.4 16201.8 14900.4 14956.9 15120.3 15122.9 15207.2 719.4 735.9 890.4 894.7 906.7 805.3 917.4 918.0 918.8 919.0 969.2 976.0 977.0 977.2 979.3 748.3 932.2 973.4 974.1 974.9 720.5 722.5 722.8 722.9 723.1 15017.2 15060.6 15072.0 15104.7 15111.5 11373.3 13376.5 14002.3 14066.3 14279.2 12604.4 12660.8 12699.3 12768.5 13160.7 4555.9 4603.5 4673.0 4722.0 4785.9 108356.0 108660.9 108815.4 109119.5 113589.4 10918.2 11002.6 11013.7 11095.0 11173.7 21748.6 21750.7 21765.5 21827.0 21832.5 7791.9 7849.6 7869.1 7897.7 8124.4 4405.9 4461.9 4484.6 4596.4 4680.2 2948.2 3607.5 3609.5 3610.0 3626.6 553.6 589.8 590.8 625.9 633.8 534.6 670.7 687.6 690.6 722.2 8805.7 9570.3 9572.9 9602.2 9952.1 589.0 632.6 662.8 680.9 686.6 4628.7 4732.7 4751.4 4752.3 4822.4 91092.5 135913.3 142538.0 149698.0 152944.0 108502.5 109731.5 111199.0 123865.0 131337.3 92621.1 109591.0 110203.0 116028.0 117114.4 9535.4 9875.0 10143.6 10307.8 10311.9 56782.0 64818.0 66527.7 67069.0 69647.7 100796.0 101067.5 102784.0 102896.5 103591.0 13395.3 13558.9 13561.7 13872.3 14142.4 15041.3 15142.8 15320.1 15555.5 15610.0 8803.6 13393.7 14137.6 14388.9 14752.9 14102.9 14150.5 14372.8 14388.4 14623.3 13345.0 13952.5 14040.4 14179.1 14200.5 10918.6 11055.7 11065.5 11066.9 11315.9 10973.5 11017.7 11735.6 11743.9 11788.6 20:00:37 INFO - PROCESS | 1652 | -------- Summary: end -------- 20:00:37 INFO - PROCESS | 1652 | 20:00:38 INFO - TEST-INFO | 1652: exit 0 20:00:38 INFO - TEST-OK | dromaeo_css | took 1115803ms 20:00:38 INFO - TEST-START | kraken 20:00:38 INFO - operating with platform_type : mac_ 20:00:38 INFO - Initialising browser for kraken test... 20:00:38 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpoT3gEs/profile http://localhost:49280/getInfo.html) 20:00:40 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 20:00:40 INFO - PROCESS | 1661 | colorDepth:24 20:00:40 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 20:00:40 INFO - PROCESS | 1661 | __metrics 20:00:40 INFO - PROCESS | 1661 | 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" 20:00:40 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:41 INFO - TEST-INFO | 1661: exit 0 20:00:41 INFO - Browser initialized. 20:00:41 INFO - Running cycle 1/1 for kraken test... 20:00:41 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/T/tmpoT3gEs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:00:53 INFO - PROCESS | 1662 | RSS: Main: 243765248 20:00:53 INFO - PROCESS | 1662 | 20:00:56 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 20:00:56 INFO - PROCESS | 1662 | RSS: Main: 294354944 20:00:56 INFO - PROCESS | 1662 | 20:00:59 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 20:01:00 INFO - PROCESS | 1662 | RSS: Main: 304656384 20:01:00 INFO - PROCESS | 1662 | 20:01:03 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 20:01:04 INFO - PROCESS | 1662 | RSS: Main: 388771840 20:01:04 INFO - PROCESS | 1662 | 20:01:06 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 20:01:06 INFO - PROCESS | 1662 | RSS: Main: 291057664 20:01:06 INFO - PROCESS | 1662 | 20:01:09 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:01:09 INFO - PROCESS | 1662 | RSS: Main: 294555648 20:01:09 INFO - PROCESS | 1662 | 20:01:12 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 20:01:13 INFO - PROCESS | 1662 | RSS: Main: 331399168 20:01:13 INFO - PROCESS | 1662 | 20:01:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 20:01:16 INFO - PROCESS | 1662 | RSS: Main: 334827520 20:01:16 INFO - PROCESS | 1662 | 20:01:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 20:01:20 INFO - PROCESS | 1662 | RSS: Main: 333430784 20:01:20 INFO - PROCESS | 1662 | 20:01:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:01:22 INFO - PROCESS | 1662 | RSS: Main: 313180160 20:01:22 INFO - PROCESS | 1662 | 20:01:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:01:24 INFO - PROCESS | 1662 | RSS: Main: 320233472 20:01:24 INFO - PROCESS | 1662 | 20:01:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:01:27 INFO - PROCESS | 1662 | RSS: Main: 318328832 20:01:27 INFO - PROCESS | 1662 | 20:01:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:01:31 INFO - PROCESS | 1662 | RSS: Main: 327667712 20:01:31 INFO - PROCESS | 1662 | 20:01:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:01:34 INFO - PROCESS | 1662 | RSS: Main: 330076160 20:01:34 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 20:01:36 INFO - PROCESS | 1662 | RSS: Main: 373342208 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | __start_tp_report 20:01:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 20:01:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 20:01:36 INFO - PROCESS | 1662 | |i|pagename|runs| 20:01:36 INFO - PROCESS | 1662 | |0;ai-astar;99;112;111;110;112;112;112;111;112;112 20:01:36 INFO - PROCESS | 1662 | |1;audio-beat-detection;141;106;107;155;110;104;128;104;141;105 20:01:36 INFO - PROCESS | 1662 | |2;audio-dft;184;184;187;185;184;186;181;182;239;183 20:01:36 INFO - PROCESS | 1662 | |3;audio-fft;77;73;57;107;56;56;60;59;127;57 20:01:36 INFO - PROCESS | 1662 | |4;audio-oscillator;83;85;93;72;70;67;95;71;88;134 20:01:36 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;86;84;88;84;86;83;87;84;86;83 20:01:36 INFO - PROCESS | 1662 | |6;imaging-darkroom;135;150;93;92;92;93;93;93;93;92 20:01:36 INFO - PROCESS | 1662 | |7;imaging-desaturate;86;85;105;133;139;85;83;83;86;84 20:01:36 INFO - PROCESS | 1662 | |8;json-parse-financial;53;53;52;55;55;54;53;54;52;53 20:01:36 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;65;68;74;78;70;73;70;69;68;70 20:01:36 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;86;82;81;80;81;74;84;83;86;83 20:01:36 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;140;136;136;136;132;135;132;145;238;142 20:01:36 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;160;214;188;162;161;163;168;159;159;161 20:01:36 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;66;66;64;65;66;65;66;69;82;80 20:01:36 INFO - PROCESS | 1662 | __end_tp_report 20:01:36 INFO - PROCESS | 1662 | __start_cc_report 20:01:36 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,1983 20:01:36 INFO - PROCESS | 1662 | __end_cc_report 20:01:36 INFO - PROCESS | 1662 | __startTimestamp1467946896646__endTimestamp 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | ------- Summary: start ------- 20:01:36 INFO - PROCESS | 1662 | Number of tests: 14 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:4.03 (3.6%) stddev-sans-first:0.73 20:01:36 INFO - PROCESS | 1662 | Values: 99.0 112.0 111.0 110.0 112.0 112.0 112.0 111.0 112.0 112.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:120.10 Median:119.00 stddev:19.36 (16.3%) stddev-sans-first:19.00 20:01:36 INFO - PROCESS | 1662 | Values: 141.0 106.0 107.0 155.0 110.0 104.0 128.0 104.0 141.0 105.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:189.50 Median:184.50 stddev:17.48 (9.5%) stddev-sans-first:18.43 20:01:36 INFO - PROCESS | 1662 | Values: 184.0 184.0 187.0 185.0 184.0 186.0 181.0 182.0 239.0 183.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:72.90 Median:58.00 stddev:24.82 (42.8%) stddev-sans-first:26.28 20:01:36 INFO - PROCESS | 1662 | Values: 77.0 73.0 57.0 107.0 56.0 56.0 60.0 59.0 127.0 57.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:85.80 Median:84.00 stddev:19.68 (23.4%) stddev-sans-first:20.85 20:01:36 INFO - PROCESS | 1662 | Values: 83.0 85.0 93.0 72.0 70.0 67.0 95.0 71.0 88.0 134.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.00 stddev:1.73 (2.0%) stddev-sans-first:1.80 20:01:36 INFO - PROCESS | 1662 | Values: 86.0 84.0 88.0 84.0 86.0 83.0 87.0 84.0 86.0 83.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:93.00 stddev:21.33 (22.9%) stddev-sans-first:19.13 20:01:36 INFO - PROCESS | 1662 | Values: 135.0 150.0 93.0 92.0 92.0 93.0 93.0 93.0 93.0 92.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:84.50 stddev:21.64 (25.6%) stddev-sans-first:22.59 20:01:36 INFO - PROCESS | 1662 | Values: 86.0 85.0 105.0 133.0 139.0 85.0 83.0 83.0 86.0 84.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.50 stddev:1.07 (2.0%) stddev-sans-first:1.13 20:01:36 INFO - PROCESS | 1662 | Values: 53.0 53.0 52.0 55.0 55.0 54.0 53.0 54.0 52.0 53.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.00 stddev:3.66 (5.2%) stddev-sans-first:3.30 20:01:36 INFO - PROCESS | 1662 | Values: 65.0 68.0 74.0 78.0 70.0 73.0 70.0 69.0 68.0 70.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:83.00 stddev:3.46 (4.2%) stddev-sans-first:3.36 20:01:36 INFO - PROCESS | 1662 | Values: 86.0 82.0 81.0 80.0 81.0 74.0 84.0 83.0 86.0 83.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:138.00 stddev:32.17 (23.3%) stddev-sans-first:34.02 20:01:36 INFO - PROCESS | 1662 | Values: 140.0 136.0 136.0 136.0 132.0 135.0 132.0 145.0 238.0 142.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:162.50 stddev:17.88 (11.0%) stddev-sans-first:18.64 20:01:36 INFO - PROCESS | 1662 | Values: 160.0 214.0 188.0 162.0 161.0 163.0 168.0 159.0 159.0 161.0 20:01:36 INFO - PROCESS | 1662 | 20:01:36 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:66.00 stddev:6.52 (9.9%) stddev-sans-first:6.83 20:01:36 INFO - PROCESS | 1662 | Values: 66.0 66.0 64.0 65.0 66.0 65.0 66.0 69.0 82.0 80.0 20:01:36 INFO - PROCESS | 1662 | -------- Summary: end -------- 20:01:36 INFO - PROCESS | 1662 | 20:01:37 INFO - TEST-INFO | 1662: exit 0 20:01:37 INFO - TEST-OK | kraken | took 59032ms 20:01:37 INFO - SUITE-END | took 1174s 20:01:37 INFO - Completed test suite (00:19:35) 20:01:37 INFO - javascript benchmark 20:01:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.367526494701, 3350.7654464187517, 3363.8822641207553, 3381.6956473917344, 3405.71051460626, 5582.9950608890385, 5609.83170504885, 5642.069058605335, 5693.174489698997, 5745.971270143648, 5669.0, 5685.829425117253, 5792.6524408535415, 5809.651420914748, 5828.591998560102, 5117.0, 5119.974400128012, 5183.50756678115, 5195.506426889439, 5279.841604751864, 5244.344456942882, 5315.760790764425, 5319.0, 5325.360956685203, 5359.651622644536, 5125.564327032188, 5161.27742116104, 5169.4572069932865, 5173.456787037382, 5180.922286165692, 5157.896842063175, 5180.559652429548, 5187.974060129675, 5201.843944681666, 5201.8959620807755, 4744.810207591692, 5164.6384753067305, 5182.067227898977, 5216.295800067019, 5230.08473517133, 5582.218489411485, 5591.2731344925305, 5722.914156287659, 5724.0, 5800.361960184377, 6243.094751261087, 6252.5935814171935, 6266.49868010558, 6266.905996410058, 6274.811755647338, 6242.0, 6299.779507717208, 6304.873902521924, 6307.306196318401, 6308.684565771739, 4893.902121957576, 5667.433256674341, 5743.54051675865, 5830.2420685310635, 5862.97068514659, 6261.7182226799905, 6279.3720627937755, 6280.2777680566405, 6281.623102613858, 6286.277078136073, 6154.630722156685, 6173.9073913891325, 6177.042558403455, 6185.721642526097, 6188.721507532172, 6042.879142417127, 6123.221615589998, 6144.723487443076, 6205.0, 6263.467605253513, 6188.81433556994, 6214.1921550198185, 6227.283862355796, 6240.781572644935, 6272.184615999982, 5122.231665250168, 6221.4089661482085, 6244.125822384779, 6249.593776404519, 6264.655443950626, 4128.2156390285745, 4888.0, 4895.534924182197, 4924.8768780780765, 4954.984228233204, 3729.4219395993664, 4429.357743127229, 4488.0, 4488.0, 4491.618212451913, 5740.913886291709, 5753.453421924911, 5813.040848260074, 5821.854453638693, 5822.417758224228, 6132.355508992456, 6142.6314421134875, 6143.170671959318, 6144.139820425144, 6159.784407545804, 5742.28221472316, 5757.798477053283, 5792.131180322901, 5818.796342128006, 5849.502792262705, 5379.112446446371, 5403.297571315704, 5404.243405923174, 5406.756695948613, 5412.56699464042, 6193.225846769154, 6250.062490626351, 6285.182926219653, 6307.0, 6307.653079080695, 5459.535939445032, 6193.628382297076, 6206.255249370104, 6212.192414986203, 6234.1583886174785, 6297.307296197506, 6321.589096708699, 6334.334894835976, 6342.619442833445, 6370.203724534434, 5086.847394578169, 6058.666773327509, 6130.917941862889, 6133.938660613337, 6174.289956655042, 4906.730129842893, 4910.803567857389, 5228.320318358741, 6269.5611307208055, 6275.403836635513, 6096.817095487142, 6124.663143527148, 6136.018237082046, 6143.815685529441, 6144.508439324933, 5928.081147422156, 6005.219321488354, 6031.215941927521, 6095.05526643371, 6113.052476866093, 5956.642601443928, 5980.43185897339, 5988.730507127103, 5991.3409524953095, 6006.249218847644, 5087.745612719424, 6094.481969032682, 6119.204503414528, 6131.96934015327, 6132.448079672851, 5742.913856292075, 5812.389699081536, 5852.18069470266, 5902.881942361215, 5909.3795151508475], "value": 5643.015771675339, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.6480947646621, 478.2300496201118, 484.18173287144725, 519.3041324625002, 525.3616855520544, 31448.842755786216, 42505.78747106264, 43260.78369608152, 43386.7830660847, 43426.697199084076, 36428.453573196355, 44803.0, 45097.549024509746, 45110.0, 45267.77366113173, 8766.56167191641, 9518.048195180478, 9695.70912872615, 9696.854547181763, 9714.562844671971, 8751.737447876541, 8984.10158984103, 9000.684976025841, 9014.0, 11665.066794656406, 11711.882881171206, 12025.639230823046, 12049.879501204963, 12062.0, 12072.215306005126, 11890.821637675399, 11970.341631210324, 11980.70048248792, 11986.820197697041, 12015.519379224821, 8752.387332886701, 11522.654320370319, 11812.350320732356, 11813.291202527877, 11842.407879605986, 37670.0, 38757.41863872044, 42033.57966420327, 42343.36484952728, 42447.78776106131, 3326.4012477753995, 3494.3884820156372, 3577.0878426001464, 3614.710823134143, 3703.8148092595534, 31736.04791856248, 32116.518252226237, 32483.863064792855, 33145.0, 33348.3330333392, 2779.5691667791525, 3279.5244689520123, 3284.8850290239725, 3321.5183798349344, 3420.675035871588, 536172.0, 537458.6254137487, 539793.3010334963, 539806.0, 542226.0, 60624.39375606276, 61299.69350153221, 61411.69294153501, 61526.69236653788, 61605.0, 65010.67494662591, 65196.0, 65256.0, 65305.67347163234, 65317.0, 16187.271572779253, 16709.498715038568, 16714.498565042824, 16739.66520669604, 16741.832581674273, 12946.223226606433, 13030.283334416508, 13037.869621303855, 13059.934700326437, 13065.346732663329, 12998.675033124058, 14181.936354773226, 14469.914756393102, 15768.369265229263, 15995.680086398206, 6717.865642687118, 6746.966265168643, 6747.426468750211, 6810.0, 6817.216020157646, 816.1960468938091, 918.1277786103228, 966.9903300966901, 983.2920297385871, 989.4211886046743, 25671.614925776128, 30841.383172336427, 30976.53535196974, 31167.90912318058, 31474.0, 1034.896510348974, 1127.8026345389524, 1205.7588482303574, 1207.9516819327127, 1217.2088142707312, 15992.76010859838, 16071.919640401724, 16173.0, 16326.713498389547, 16475.704859028243, 687638.0, 689859.0, 690446.0, 690481.0, 691570.0, 60745.69627151836, 61584.38415615876, 61734.765304693654, 61843.38156618466, 62005.68997154985, 1270.4092596942282, 1309.5612969655272, 1408.4155075643698, 1418.9574312770633, 1435.7128574285184, 23681.52636947286, 26417.867910661094, 27869.860650696617, 31729.365412692077, 32530.02409927706, 50888.236676449145, 51433.74283128561, 51682.48317516777, 51945.740271298404, 51973.480265196864, 466607.0, 495317.0, 502096.0, 503045.0, 505388.0, 34698.0, 39378.80310598428, 40599.797001014806, 40640.59359406368, 40809.59190408058, 36982.815085925475, 44569.81942064966, 48761.2685809706, 51637.0, 52910.47089529209, 39791.60208397879, 41033.97415064647, 41412.0, 41469.377959331236, 42292.0, 33065.834670826494, 40299.0, 40959.38560921648, 41176.58823411728, 41351.58648413477, 38022.049448764, 38714.22571548497, 38889.833305000895, 39156.0, 39361.0, 27961.720382796724, 30282.637281322834, 32583.837080814443, 35369.0, 35563.0, 22845.65731514062, 25646.0, 26063.348416288987, 26219.21342359732, 26573.468530629667], "value": 20561.679223767973, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.4992559895339, 387.103854576655, 389.2526349409134, 399.30520893645064, 400.31745873286053, 19614.019299035044, 21251.362459126212, 22107.66838497422, 22144.557108857814, 22391.0, 21895.452613684625, 22044.779552204473, 22164.556708865854, 22409.55180896381, 22416.215432459867, 4378.846740364096, 5617.241672374238, 5618.353889302742, 5665.54675625951, 5673.205751194836, 3995.8601448949294, 4234.978825105885, 5584.078627026556, 5691.630044047124, 5934.228550288456, 5467.617266791326, 6220.1602783624085, 6266.811995640138, 6276.121343011982, 6290.559660823744, 6263.248410190783, 6470.870582588345, 6839.487038472134, 6843.281455447156, 6863.656817159172, 3813.0848596336955, 4029.0, 4143.6685065194715, 6081.695915204222, 6088.4215999479975, 13158.14472059313, 13582.117162384413, 13714.862851371458, 13723.176609403468, 13745.587632371045, 2157.1479265689964, 2290.278562252885, 2356.104680221522, 2358.657994590792, 2378.6907701998803, 9881.25890558211, 9964.455509396055, 10142.087212150942, 10590.09984151348, 10651.094656954168, 1887.962240755191, 1939.0111043367983, 1954.775200851892, 1987.930422435208, 1991.790861959488, 117575.41212293884, 123568.0, 123904.38047809704, 125499.37250313781, 127206.0, 9546.665866694633, 11550.249233799945, 11586.246893951866, 11662.60916512113, 11830.645080647595, 14742.410303587736, 14828.3327250274, 14837.035592686441, 14854.702905942037, 14856.18290993984, 8595.398322117517, 8778.473291602397, 8809.559522023874, 8868.822623547621, 8916.242119419792, 8745.737627871047, 8769.561521923879, 8814.030456649763, 8919.375643705009, 8926.598303076376, 4554.476235232924, 4628.236341003697, 4636.304554316812, 4693.78877950493, 4695.5539223773685, 1773.9024353660673, 1837.5865430278348, 1878.840298574609, 1930.7779605345283, 1958.2265005322818, 949.5424523356614, 949.7198326493701, 974.6588693957058, 981.7349315684725, 984.7735020945223, 21848.563028739336, 21974.01116949741, 22041.0, 22051.66922496164, 22063.448413789785, 976.7460460280379, 985.9014098590227, 1007.1992765751245, 1021.5198856537415, 1025.9487025648837, 10941.179411544166, 11443.485043173077, 11487.023602993671, 11499.022583080365, 11529.423528823692, 515647.0, 521532.0, 523468.0, 581942.0, 612093.0, 123355.0, 124335.0, 136818.0, 140727.0, 146403.0, 439.98680039598224, 443.09608398865953, 462.88196509890435, 463.9257718764981, 464.72116729961755, 11177.752454067402, 11255.831162532731, 11459.0, 11684.88315116872, 11938.522459101887, 58307.0, 58742.41257587369, 59731.70134149301, 60011.09983350341, 60256.69871650789, 83707.16292836994, 84028.15971840204, 84101.57949210214, 84781.57609211914, 86523.56738216268, 7959.4030447715495, 8034.236747508978, 8128.14654461273, 8361.122082181284, 8365.95817020911, 11697.941510292394, 12412.441440135035, 12501.374931253218, 12657.177283476545, 12692.238465692088, 10893.673189804318, 11105.888941110485, 11144.164187685794, 11177.385243811668, 11184.496697648789, 4997.5002499749735, 7443.776686699408, 9071.546422678972, 10775.47024683581, 10971.01260886524, 9794.54401883219, 10437.58249670035, 11242.213045086766, 11435.142364322543, 11685.707857303636, 8355.582220889053, 8367.539785311867, 8379.95810020946, 8404.621792019252, 8669.263112635497, 5512.283403157564, 10565.366078035342, 10974.231803773979, 11094.779574246664, 11274.0], "value": 9124.636364021244, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1572.9449469268575, 1579.928903199356, 1791.9552011199726, 1920.1167462967035, 1928.8456923446126, 8730.519821409827, 9060.773480662987, 9225.723228303144, 9228.307876909243, 9236.67671631493, 7987.0, 8225.753227403187, 8684.478931264128, 8917.73246802597, 9036.50299233542, 2361.822863285256, 2386.498835244592, 2388.4984153327823, 2392.28231530541, 2394.5450364430703, 2372.217168334454, 2375.429896824758, 2419.8064154867657, 2419.8911049002836, 2421.5883299838983, 2095.067694875781, 2180.8800515971616, 2182.8253739700867, 2183.410479170623, 2184.7050648162535, 2312.329424466911, 2383.845050071757, 2388.9641655375185, 2389.450426401929, 2390.581648211556, 2377.976220237793, 2396.508715713275, 2401.3156250468705, 2406.2420337593776, 2412.276317104879, 9148.8627670585, 9221.90778092224, 9226.677066302715, 9231.584578693975, 9262.490563019099, 5324.41431442541, 5445.754941027663, 5492.505674489315, 5496.725163741797, 5501.972490137524, 3561.554805649294, 3614.8554057837655, 3665.871694490707, 3683.3001729671278, 3689.631036896316, 1047.3297089862494, 1071.560660129351, 1095.2278643556353, 1113.1651261553834, 1114.587602587048, 12187.695307617292, 12216.083793715507, 12233.694157646041, 12238.938805306005, 12296.446659900326, 4732.574068333866, 4738.431388233365, 4849.684770489906, 4886.511348865085, 4899.706017638881, 10189.337693049929, 10299.330543514647, 10332.845007324897, 10350.378977261238, 10351.896481035245, 5473.589480788957, 5479.589030822704, 5491.560675145979, 5503.779848806083, 5509.311336082989, 4831.299461578052, 4998.300237966688, 5002.499750024968, 5025.7989680412375, 5028.969061342416, 3946.644801967779, 3950.150717595731, 4034.092329225901, 4040.0, 4077.1234184650443, 1258.7797135501435, 1288.1240756285629, 1296.2222666400085, 1301.3883474766844, 1311.1543054729646, 827.6192951242496, 935.9625614975461, 945.6217512994857, 985.103555764251, 985.4284514981437, 6162.0, 6224.097505861625, 6278.780242691484, 6284.780032698834, 6289.905651415233, 440.89418539550275, 456.18798538601345, 463.0391936731229, 952.5999080386255, 1037.2169012395743, 4138.482689663792, 4188.246115699142, 4193.958060419418, 4263.509696384894, 4263.637590804754, 11057.0, 11197.0, 11231.0, 11322.37726925027, 11330.886691132982, 11273.887261127284, 11287.943560282147, 11293.71765705864, 11300.152488563226, 11301.039411650101, 8025.117237103797, 8436.28291595209, 8571.699990500303, 8572.442791218551, 8589.14108589136, 6061.787837425669, 6148.1085242640465, 6206.72069756871, 6222.751089956351, 6236.844078898064, 10249.282550221413, 10326.277160598986, 10331.380117192692, 10348.844767328346, 10382.117520010883, 9899.406035637885, 10343.482825858526, 10560.577576896838, 10574.471276436301, 10588.629397971034, 7674.424418168548, 7729.4202934779, 7834.608269586612, 7837.294643482114, 7871.134175240604, 8354.331653467829, 8472.61873215719, 8550.700725474579, 8554.059053503985, 8611.569421528773, 7574.091109066947, 7648.273414025659, 7660.885086723592, 7716.807079823049, 7803.960980195063, 7412.740554080581, 7465.738699145504, 7481.251874812475, 7618.961905190438, 7638.465307428427, 6932.6533673315125, 7089.936509523613, 7139.286071392819, 7166.749163779243, 7186.353228209487, 4638.721676699409, 4945.975270123627, 5006.74831292177, 5091.236314552847, 5154.1237989542615, 4643.233866412139, 5182.948170518397, 5199.4540573239265, 5229.712365819916, 5345.091334473072], "value": 4680.150690862434, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.61034680782, 311.5762562914436, 315.8878598097675, 319.3517160164866, 322.74825636003897, 5434.72826358682, 5436.015854213213, 5448.891022179554, 5468.261784659075, 5505.394406615269, 4674.789634466449, 5087.049511283456, 5391.0, 5392.406835248129, 5421.292292927725, 3582.6775590196876, 3922.509686289221, 3951.841926322958, 4059.04612416082, 4174.538911381022, 4078.796060196993, 4121.7634709587155, 4126.587341265865, 4146.9792651036705, 4147.771872547009, 4109.363048727452, 4111.177764447108, 4122.9381559276635, 4141.420201171838, 4149.937750933738, 3033.924151896198, 3579.3736096183065, 3815.4276858471176, 4027.2952233359047, 4130.380442933554, 3546.609872914003, 3580.7135429165605, 3581.6955558777536, 3592.263585964871, 3592.3533763922483, 5320.733963301819, 5333.4399888011585, 5358.598105142091, 5361.900810333872, 5370.91943620846, 4555.293929440909, 4800.783964721596, 4826.951730482685, 4836.904381196037, 4855.951440485585, 4697.812087516495, 5681.528535087209, 5687.090065589486, 5722.170285308607, 5730.656160630376, 3796.822984874698, 3969.503812023497, 3997.8200980955635, 4002.239574480839, 4006.939895901564, 5431.918521222185, 5485.189887337169, 5693.459121383504, 5856.677882716449, 5890.352061273256, 4018.517777866675, 4020.8994775130855, 4031.23406552754, 4055.3308704063497, 4082.3672330788777, 4082.3672330788777, 4132.285101682768, 4143.0, 4144.44050053245, 4148.460700109027, 4635.502154606029, 4683.344331793552, 4730.219513780256, 4785.665003449794, 4799.28010798383, 5066.544011039025, 5489.890202196014, 5645.717714114277, 5763.7982670606325, 5765.848589015902, 1160.843286156375, 1208.6374087773634, 1240.8212198411545, 1395.1838174667932, 1400.9649758755909, 786.0057027859762, 849.4096602860952, 849.8017794909149, 880.823835232956, 884.9867251991225, 4305.827766889352, 4576.8626941191815, 4843.055604157226, 4844.224924012141, 5125.56432703217, 5839.817299571659, 5906.0, 5913.319968203712, 5920.5559583031445, 5923.733431995571, 4257.914231870853, 4731.4795372509, 4784.162771514971, 5294.41761406245, 5311.787528498817, 2847.6933683716256, 2903.724146206107, 3081.3683194944983, 3092.6443459002053, 3094.659587445379, 4796.616270698336, 5140.460251673595, 5989.580729348903, 6095.8910955412175, 6117.461253579803, 5662.462066103796, 5962.5826192167, 6018.518518518508, 6037.732076264034, 6072.574919755663, 5064.696118232918, 5295.232191332235, 6032.3967603239325, 6120.571559990847, 6122.265328160649, 5549.724612908688, 5799.246098007232, 5832.62087964281, 5870.970645146747, 5882.5293077084725, 4863.416390033077, 5004.374453193351, 5042.798288068583, 5568.0, 5815.621984570989, 4895.751583346224, 5578.86052848682, 5820.76716931318, 6136.12178318247, 6139.201903752483, 3755.267722794138, 3976.0258736609717, 3979.547465175248, 3985.262726395626, 4012.8194231260245, 5257.63196576236, 5735.8566035849435, 5801.506871915934, 5816.883662326645, 5853.546407619525, 5323.547498462519, 5479.4520547944885, 5686.374498805211, 5688.374278829243, 5704.429557044263, 5278.89442211146, 5316.308879845596, 5682.914756278742, 5740.799072032459, 5770.0, 4900.191468407673, 5614.214010038516, 5650.378458369494, 5660.433956604306, 5705.972924873563, 5259.763310651107, 5465.808696695596, 5636.943630563642, 5664.289890121977, 5665.801696940587, 5471.644343117844, 5557.944420555743, 5569.607598100475, 5572.637778544544, 5574.693391863487], "value": 4159.607596792395, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [790.7706765038139, 809.9878501822471, 825.9958700206498, 839.7438781171742, 855.5636625321092, 15496.9926954748, 15567.610809729735, 16105.27526261321, 16199.352025918965, 16201.837981620194, 14900.40398384066, 14956.850431495683, 15120.278349897015, 15122.924385378084, 15207.163606001666, 719.4208662027066, 735.9300866417682, 890.363390176024, 894.6645008121955, 906.7053207707488, 805.2993895311088, 917.3853518142827, 918.008550765172, 918.8024574716435, 918.9632414703437, 969.2100937735757, 975.9609615615367, 977.0180968127022, 977.2377545514474, 979.3291595257236, 748.3003391828657, 932.2076235200093, 973.3770386952356, 974.0989584634185, 974.8927617962019, 720.4920531025614, 722.4689852958072, 722.7867779005206, 722.902408174895, 723.1141851232251, 15017.174055426947, 15060.623484412978, 15072.020318679251, 15104.697906041927, 15111.54665360041, 11373.31760094397, 13376.464941402332, 14002.299885005708, 14066.296685165804, 14279.21464319462, 12604.432800523999, 12660.81008784869, 12699.301538415384, 12768.489260429571, 13160.670983225496, 4555.881355594104, 4603.5166307537565, 4673.0, 4722.0, 4785.928211076836, 108356.0, 108660.91339086666, 108815.36776948352, 109119.45440272748, 113589.43205283921, 10918.1811364148, 11002.559897604006, 11013.669589912315, 11095.0, 11173.720656983478, 21748.565028699653, 21750.673739893915, 21765.455863603536, 21827.01778419975, 21832.454188645093, 7791.883121753178, 7849.568273744999, 7869.0950540688555, 7897.68409263623, 8124.390670699603, 4405.933910991338, 4461.910761784746, 4484.596386325246, 4596.448426188812, 4680.204365257914, 2948.2187220386613, 3607.494950706903, 3609.530761001053, 3609.9639003609627, 3626.5648122225502, 553.5891758059746, 589.7876764364826, 590.8168467775004, 625.8748250349948, 633.7940169444948, 534.636447215897, 670.661316035399, 687.5591649643744, 690.5649440852231, 722.1868534139751, 8805.735827925173, 9570.282228832726, 9572.946975832652, 9602.183814375856, 9952.118852642361, 589.0104624231333, 632.6172665537375, 662.8475450646379, 680.8638272345551, 686.6257889450262, 4628.652851036119, 4732.73969931657, 4751.382320298409, 4752.310914917318, 4822.421309442819, 91092.54453727689, 135913.3204333972, 142538.0, 149698.0, 152944.0, 108502.45748771206, 109731.45134274277, 111199.0, 123865.0, 131337.34331328282, 92621.07378926124, 109591.0, 110203.0, 116028.0, 117114.41442792732, 9535.38020028696, 9875.0, 10143.594256229668, 10307.793844123225, 10311.948440257751, 56782.0, 64818.0, 66527.66736166288, 67069.0, 69647.65176174087, 100796.0, 101067.49466252622, 102784.0, 102896.48551757193, 103591.0, 13395.330233488092, 13558.86441135576, 13561.660958476117, 13872.306384680927, 14142.434302628191, 15041.323140458488, 15142.772858407354, 15320.080795152326, 15555.533333999998, 15610.0, 8803.647854085764, 13393.66515837112, 14137.646558836112, 14388.909807963, 14752.852471475147, 14102.929485352508, 14150.504732334319, 14372.784408233676, 14388.35252413623, 14623.268836558342, 13345.0, 13952.511662091778, 14040.438382464587, 14179.078359906573, 14200.502982395567, 10918.563257469612, 11055.72360690989, 11065.514507531698, 11066.944665276622, 11315.886841131813, 10973.451327433437, 11017.724556886142, 11735.647930562096, 11743.941280293544, 11788.646340609796], "value": 8018.439281302955, "unit": "score"}], "name": "dromaeo_css", "value": 7408.076464519982, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 112.0, 111.0, 110.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 106.0, 107.0, 155.0, 110.0, 104.0, 128.0, 104.0, 141.0, 105.0], "value": 120.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 187.0, 185.0, 184.0, 186.0, 181.0, 182.0, 239.0, 183.0], "value": 189.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 57.0, 107.0, 56.0, 56.0, 60.0, 59.0, 127.0, 57.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 93.0, 72.0, 70.0, 67.0, 95.0, 71.0, 88.0, 134.0], "value": 85.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 88.0, 84.0, 86.0, 83.0, 87.0, 84.0, 86.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 150.0, 93.0, 92.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 105.0, 133.0, 139.0, 85.0, 83.0, 83.0, 86.0, 84.0], "value": 96.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 55.0, 55.0, 54.0, 53.0, 54.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 74.0, 78.0, 70.0, 73.0, 70.0, 69.0, 68.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 81.0, 80.0, 81.0, 74.0, 84.0, 83.0, 86.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 136.0, 136.0, 136.0, 132.0, 135.0, 132.0, 145.0, 238.0, 142.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 214.0, 188.0, 162.0, 161.0, 163.0, 168.0, 159.0, 159.0, 161.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 64.0, 65.0, 66.0, 65.0, 66.0, 69.0, 82.0, 80.0], "value": 68.9, "unit": "score"}], "name": "kraken", "value": 1454.7, "alertThreshold": 2.0}]} 20:01:37 INFO - Return code: 0 20:01:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:01:37 INFO - # TBPL SUCCESS # 20:01:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:01:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:01:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:01:37 INFO - 2016-07-07 20:01:37.942 screenresolution[1666:10095] starting screenresolution argv=screenresolution get 20:01:37 INFO - 2016-07-07 20:01:37.945 screenresolution[1666:10095] Display 0: 1600x1200x32@60 20:01:37 INFO - 2016-07-07 20:01:37.951 screenresolution[1667:10098] starting screenresolution argv=screenresolution list 20:01:37 INFO - Available Modes on Display 0 20:01:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:01:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:01:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:01:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:01:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:01:38 INFO - Intel Iris: 20:01:38 INFO - Chipset Model: Intel Iris 20:01:38 INFO - Type: GPU 20:01:38 INFO - Bus: Built-In 20:01:38 INFO - VRAM (Dynamic, Max): 1536 MB 20:01:38 INFO - Vendor: Intel (0x8086) 20:01:38 INFO - Device ID: 0x0a2e 20:01:38 INFO - Revision ID: 0x0009 20:01:38 INFO - Displays: 20:01:38 INFO - Display: 20:01:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:01:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:01:38 INFO - Display Serial Number: 1600x1200 60 20:01:38 INFO - Main Display: Yes 20:01:38 INFO - Mirror: Off 20:01:38 INFO - Online: Yes 20:01:38 INFO - Rotation: Supported 20:01:38 INFO - Return code: 0 20:01:38 INFO - Running post-action listener: _resource_record_post_action 20:01:38 INFO - ##### 20:01:38 INFO - ##### Finished run-tests step (success) 20:01:38 INFO - ##### 20:01:38 INFO - Running post-run listener: _resource_record_post_run 20:01:38 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 36972032; Write bytes: 706681344; Read time: 234; Write time: 1943 20:01:38 INFO - TinderboxPrint: CPU usage
53.6% 20:01:38 INFO - TinderboxPrint: I/O read bytes / time
36,972,032 / 234 20:01:38 INFO - TinderboxPrint: I/O write bytes / time
706,681,344 / 1,943 20:01:38 INFO - TinderboxPrint: CPU idle
2,246.2 (46.4%) 20:01:38 INFO - TinderboxPrint: CPU system
969.6 (20.0%) 20:01:38 INFO - TinderboxPrint: CPU user
1,625.9 (33.6%) 20:01:38 INFO - TinderboxPrint: Swap in / out
443,744,256 / 0 20:01:38 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390435328; Write bytes: 385459712; Read time: 29592; Write time: 766 20:01:38 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36005376; Write bytes: 296043520; Read time: 220; Write time: 1118 20:01:38 INFO - Running post-run listener: _upload_blobber_files 20:01:38 INFO - Blob upload gear active. 20:01:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:01:38 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 20:01:38 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'] 20:01:38 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 20:01:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:01:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:01:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:01:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:40 INFO - (blobuploader) - INFO - Done attempting. 20:01:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:01:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:01:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:41 INFO - (blobuploader) - INFO - Done attempting. 20:01:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:01:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:01:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:01:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:01:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:01:43 INFO - (blobuploader) - INFO - Done attempting. 20:01:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:01:43 INFO - Return code: 0 20:01:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:01:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:01:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b662c1e98b816497c25e5b1570452dbe98dc4346289690e8037fc104ee86a639c839ff18a1be7917d0dbb573df8e081dc3c5a8614986ca37a03cebba8ef0525b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2733ff653d77085af35251549424fb8b13efe344a764e17849812ba8873beeccaf8f16be88ea0df8a37f9621d61534637077c6be31acbe2c186f8ed0b23d6005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d84bcbedeb2ca2b206311cf4cab4dc0ba0247fe00ae9b1a3b23e30c7d93617835e12af4b5e41d005a44fe267e19ff5cd1f2a4a024406e7e55fe5484d3c8f496"} 20:01:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:01:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:01:43 INFO - Contents: 20:01:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b662c1e98b816497c25e5b1570452dbe98dc4346289690e8037fc104ee86a639c839ff18a1be7917d0dbb573df8e081dc3c5a8614986ca37a03cebba8ef0525b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2733ff653d77085af35251549424fb8b13efe344a764e17849812ba8873beeccaf8f16be88ea0df8a37f9621d61534637077c6be31acbe2c186f8ed0b23d6005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d84bcbedeb2ca2b206311cf4cab4dc0ba0247fe00ae9b1a3b23e30c7d93617835e12af4b5e41d005a44fe267e19ff5cd1f2a4a024406e7e55fe5484d3c8f496"} 20:01:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:01:43 INFO - Copying logs to upload dir... 20:01:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:01:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.855491 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-07 20:01:43.751731) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:01:43.755459) ========= 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.OPLIdiP2YT/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.pufd3dBZqm/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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/b662c1e98b816497c25e5b1570452dbe98dc4346289690e8037fc104ee86a639c839ff18a1be7917d0dbb573df8e081dc3c5a8614986ca37a03cebba8ef0525b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2733ff653d77085af35251549424fb8b13efe344a764e17849812ba8873beeccaf8f16be88ea0df8a37f9621d61534637077c6be31acbe2c186f8ed0b23d6005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d84bcbedeb2ca2b206311cf4cab4dc0ba0247fe00ae9b1a3b23e30c7d93617835e12af4b5e41d005a44fe267e19ff5cd1f2a4a024406e7e55fe5484d3c8f496"} build_url:https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011116 build_url: 'https://queue.taskcluster.net/v1/task/MlAapmdKR_y9x9F1MN0myQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b662c1e98b816497c25e5b1570452dbe98dc4346289690e8037fc104ee86a639c839ff18a1be7917d0dbb573df8e081dc3c5a8614986ca37a03cebba8ef0525b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2733ff653d77085af35251549424fb8b13efe344a764e17849812ba8873beeccaf8f16be88ea0df8a37f9621d61534637077c6be31acbe2c186f8ed0b23d6005", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d84bcbedeb2ca2b206311cf4cab4dc0ba0247fe00ae9b1a3b23e30c7d93617835e12af4b5e41d005a44fe267e19ff5cd1f2a4a024406e7e55fe5484d3c8f496"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 20:01:43.792095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:01:43.792774) ========= 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.OPLIdiP2YT/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.pufd3dBZqm/Listeners TMPDIR=/var/folders/gx/03x7wz8n29n54z05qtqj40wr00000w/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.005150 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 20:01:43.848817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:01:43.849493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 20:01:43.850195) ========= ========= Total master_lag: 0.20 =========