builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0021 starttime: 1470655194.51 results: success (0) buildid: 20160808012421 builduid: f64ec4b55952477e87b269089c3452c5 revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.509230) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.509701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.510011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.539147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.539549) ========= 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.fXXpEJAFsl/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.arG9yPVGUw/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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-08-08 04:19:54-- 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% 35.1M=0s 2016-08-08 04:19:54 (35.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.095441 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.658846) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.659219) ========= 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.fXXpEJAFsl/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.arG9yPVGUw/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.028424 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:54.708322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 04:19:54.708696) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f8fc21bb232095b7b4c995d259558212cb90a44b --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 f8fc21bb232095b7b4c995d259558212cb90a44b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXXpEJAFsl/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.arG9yPVGUw/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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-08-08 04:19:54,799 truncating revision to first 12 chars 2016-08-08 04:19:54,799 Setting DEBUG logging. 2016-08-08 04:19:54,799 attempt 1/10 2016-08-08 04:19:54,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f8fc21bb2320?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-08 04:19:55,781 unpacking tar archive at: fx-team-f8fc21bb2320/testing/mozharness/ program finished with exit code 0 elapsedTime=1.279903 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-08 04:19:56.013650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:56.014012) ========= script_repo_revision: f8fc21bb232095b7b4c995d259558212cb90a44b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:56.014473) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:56.014746) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-08 04:19:56.036097) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-08 04:19:56.036761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXXpEJAFsl/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.arG9yPVGUw/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:19:56 INFO - MultiFileLogger online at 20160808 04:19:56 in /builds/slave/test 04:19:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:19:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:56 INFO - {'append_to_log': False, 04:19:56 INFO - 'base_work_dir': '/builds/slave/test', 04:19:56 INFO - 'blob_upload_branch': 'Fx-Team', 04:19:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:56 INFO - 'branch': 'Fx-Team', 04:19:56 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:56 INFO - 'config_files': ('talos/mac_config.py',), 04:19:56 INFO - 'default_actions': ('clobber', 04:19:56 INFO - 'read-buildbot-config', 04:19:56 INFO - 'download-and-extract', 04:19:56 INFO - 'populate-webroot', 04:19:56 INFO - 'create-virtualenv', 04:19:56 INFO - 'install', 04:19:56 INFO - 'run-tests'), 04:19:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:56 INFO - 'download_minidump_stackwalk': True, 04:19:56 INFO - 'download_symbols': 'ondemand', 04:19:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:56 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:56 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:56 INFO - 'installer_path': 'installer.exe', 04:19:56 INFO - 'log_level': 'info', 04:19:56 INFO - 'log_name': 'talos', 04:19:56 INFO - 'log_to_console': True, 04:19:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:19:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:19:56 INFO - 'opt_config_files': (), 04:19:56 INFO - 'pip_index': False, 04:19:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:19:56 INFO - 'cmd': ('bash', 04:19:56 INFO - '-c', 04:19:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:19:56 INFO - 'enabled': True, 04:19:56 INFO - 'halt_on_failure': False, 04:19:56 INFO - 'name': 'check_screen_resolution'},), 04:19:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:19:56 INFO - 'cmd': ('bash', 04:19:56 INFO - '-c', 04:19:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:19:56 INFO - 'enabled': True, 04:19:56 INFO - 'halt_on_failure': False, 04:19:56 INFO - 'name': 'check_screen_resolution'},), 04:19:56 INFO - 'run_cmd_checks_enabled': True, 04:19:56 INFO - 'sps_profile': False, 04:19:56 INFO - 'sps_profile_interval': 0, 04:19:56 INFO - 'suite': 'dromaeojs-e10s', 04:19:56 INFO - 'system_bits': '32', 04:19:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:56 INFO - 'title': 't-yosemite-r7-0021', 04:19:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:56 INFO - 'use_talos_json': True, 04:19:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:56 INFO - 'work_dir': 'build'} 04:19:56 INFO - [mozharness: 2016-08-08 11:19:56.239907Z] Running clobber step. 04:19:56 INFO - Running pre-action listener: _resource_record_pre_action 04:19:56 INFO - Running main action method: clobber 04:19:56 INFO - rmtree: /builds/slave/test/build 04:19:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:58 INFO - Running post-action listener: _resource_record_post_action 04:19:58 INFO - [mozharness: 2016-08-08 11:19:58.255152Z] Finished clobber step (success) 04:19:58 INFO - [mozharness: 2016-08-08 11:19:58.255346Z] Running read-buildbot-config step. 04:19:58 INFO - Running pre-action listener: _resource_record_pre_action 04:19:58 INFO - Running main action method: read_buildbot_config 04:19:58 INFO - Using buildbot properties: 04:19:58 INFO - { 04:19:58 INFO - "project": "", 04:19:58 INFO - "product": "firefox", 04:19:58 INFO - "script_repo_revision": "production", 04:19:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 04:19:58 INFO - "repository": "", 04:19:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 04:19:58 INFO - "buildid": "20160808012421", 04:19:58 INFO - "pgo_build": "False", 04:19:58 INFO - "basedir": "/builds/slave/test", 04:19:58 INFO - "buildnumber": 761, 04:19:58 INFO - "slavename": "t-yosemite-r7-0021", 04:19:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:19:58 INFO - "platform": "yosemite_r7", 04:19:58 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 04:19:58 INFO - "branch": "fx-team", 04:19:58 INFO - "repo_path": "integration/fx-team", 04:19:58 INFO - "revision": "f8fc21bb232095b7b4c995d259558212cb90a44b", 04:19:58 INFO - "stage_platform": "macosx64", 04:19:58 INFO - "builduid": "f64ec4b55952477e87b269089c3452c5", 04:19:58 INFO - "slavebuilddir": "test" 04:19:58 INFO - } 04:19:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 04:19:58 INFO - Running post-action listener: _resource_record_post_action 04:19:58 INFO - [mozharness: 2016-08-08 11:19:58.260994Z] Finished read-buildbot-config step (success) 04:19:58 INFO - [mozharness: 2016-08-08 11:19:58.261209Z] Running download-and-extract step. 04:19:58 INFO - Running pre-action listener: _resource_record_pre_action 04:19:58 INFO - Running main action method: download_and_extract 04:19:58 INFO - mkdir: /builds/slave/test/build/tests 04:19:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:58 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 04:19:58 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:19:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 04:19:59 INFO - Downloaded 1199 bytes. 04:19:59 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 04:19:59 INFO - Using the following test package requirements: 04:19:59 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:19:59 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 04:19:59 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 04:19:59 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'jsshell-mac.zip'], 04:19:59 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 04:19:59 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 04:19:59 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 04:19:59 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 04:19:59 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 04:19:59 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 04:19:59 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 04:19:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:59 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:19:59 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:20:00 INFO - Downloaded 16320444 bytes. 04:20:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:20:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:07 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:20:07 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 04:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:20:08 INFO - Downloaded 16320444 bytes. 04:20:08 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 04:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:15 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:20:15 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 04:20:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:20:16 INFO - Downloaded 14413723 bytes. 04:20:16 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 04:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:16 INFO - trying https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:20:16 INFO - Downloading https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 04:20:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 04:20:19 INFO - Downloaded 111901101 bytes. 04:20:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:20:19 INFO - mkdir: /builds/slave/test/properties 04:20:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:20:19 INFO - Writing to file /builds/slave/test/properties/build_url 04:20:19 INFO - Contents: 04:20:19 INFO - build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 04:20:19 INFO - Running post-action listener: _resource_record_post_action 04:20:19 INFO - Running post-action listener: set_extra_try_arguments 04:20:19 INFO - [mozharness: 2016-08-08 11:20:19.925530Z] Finished download-and-extract step (success) 04:20:19 INFO - [mozharness: 2016-08-08 11:20:19.925692Z] Running populate-webroot step. 04:20:19 INFO - Running pre-action listener: _resource_record_pre_action 04:20:19 INFO - Running main action method: populate_webroot 04:20:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:20:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:20:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:20:19 INFO - '--tppagecycles', 04:20:19 INFO - '7'], 04:20:19 INFO - 'tests': ['tsvgm']}}, 04:20:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:20:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:20:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:20:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:20:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:20:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['damp', 'tps']}, 04:20:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'tests': ['damp', 'tps']}, 04:20:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['dromaeo_dom']}, 04:20:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:20:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['basic_compositor_video']}, 04:20:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:20:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['a11yr', 04:20:19 INFO - 'ts_paint', 04:20:19 INFO - 'tpaint', 04:20:19 INFO - 'sessionrestore', 04:20:19 INFO - 'sessionrestore_no_auto_restore', 04:20:19 INFO - 'tabpaint']}, 04:20:19 INFO - 'other-e10s': {'tests': ['a11yr', 04:20:19 INFO - 'ts_paint', 04:20:19 INFO - 'tpaint', 04:20:19 INFO - 'sessionrestore', 04:20:19 INFO - 'sessionrestore_no_auto_restore', 04:20:19 INFO - 'tabpaint']}, 04:20:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:20:19 INFO - 'ts_paint', 04:20:19 INFO - 'tpaint', 04:20:19 INFO - 'sessionrestore', 04:20:19 INFO - 'sessionrestore_no_auto_restore', 04:20:19 INFO - 'tabpaint']}, 04:20:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:20:19 INFO - 'ts_paint', 04:20:19 INFO - 'tpaint', 04:20:19 INFO - 'sessionrestore', 04:20:19 INFO - 'sessionrestore_no_auto_restore', 04:20:19 INFO - 'tabpaint']}, 04:20:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['a11yr', 04:20:19 INFO - 'ts_paint', 04:20:19 INFO - 'tpaint', 04:20:19 INFO - 'sessionrestore', 04:20:19 INFO - 'sessionrestore_no_auto_restore', 04:20:19 INFO - 'tabpaint']}, 04:20:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['a11yr', 04:20:19 INFO - 'ts_paint', 04:20:19 INFO - 'tpaint', 04:20:19 INFO - 'sessionrestore', 04:20:19 INFO - 'sessionrestore_no_auto_restore', 04:20:19 INFO - 'tabpaint']}, 04:20:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['tsvgx', 04:20:19 INFO - 'tsvgr_opacity', 04:20:19 INFO - 'tart', 04:20:19 INFO - 'tscrollx', 04:20:19 INFO - 'cart']}, 04:20:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:20:19 INFO - 'tsvgr_opacity', 04:20:19 INFO - 'tart', 04:20:19 INFO - 'tscrollx', 04:20:19 INFO - 'cart']}, 04:20:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'talos_options': ['--disable-e10s'], 04:20:19 INFO - 'tests': ['tp5o']}, 04:20:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'tests': ['tp5o']}, 04:20:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'talos_options': ['--disable-e10s', 04:20:19 INFO - '--xperf_path', 04:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:19 INFO - 'tests': ['tp5n']}, 04:20:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:20:19 INFO - 'talos_options': ['--xperf_path', 04:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:20:19 INFO - 'tests': ['tp5n']}}, 04:20:19 INFO - 'talos.zip': {'path': '', 04:20:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:20:19 INFO - Running post-action listener: _resource_record_post_action 04:20:19 INFO - [mozharness: 2016-08-08 11:20:19.944315Z] Finished populate-webroot step (success) 04:20:19 INFO - [mozharness: 2016-08-08 11:20:19.944449Z] Running create-virtualenv step. 04:20:19 INFO - Running pre-action listener: _resource_record_pre_action 04:20:19 INFO - Running main action method: create_virtualenv 04:20:19 INFO - Creating virtualenv /builds/slave/test/build/venv 04:20:19 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 04:20:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:20:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:20:20 INFO - Using real prefix '/tools/python27' 04:20:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:20:20 INFO - Installing distribute.............................................................................................................................................................................................done. 04:20:23 INFO - Installing pip.................done. 04:20:23 INFO - Return code: 0 04:20:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:20:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:23 INFO - 'HOME': '/Users/cltbld', 04:20:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:23 INFO - 'LOGNAME': 'cltbld', 04:20:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:23 INFO - 'MOZ_NO_REMOTE': '1', 04:20:23 INFO - 'NO_EM_RESTART': '1', 04:20:23 INFO - 'PAGER': '/bin/cat', 04:20:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:23 INFO - 'PWD': '/builds/slave/test', 04:20:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:23 INFO - 'SHELL': '/bin/bash', 04:20:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:23 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:23 INFO - 'USER': 'cltbld', 04:20:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:23 INFO - 'XPC_FLAGS': '0x0', 04:20:23 INFO - 'XPC_SERVICE_NAME': '0', 04:20:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:23 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 04:20:24 INFO - Cleaning up... 04:20:24 INFO - Return code: 0 04:20:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:24 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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:24 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 04:20:24 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 04:20:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:24 INFO - 'HOME': '/Users/cltbld', 04:20:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:24 INFO - 'LOGNAME': 'cltbld', 04:20:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:24 INFO - 'MOZ_NO_REMOTE': '1', 04:20:24 INFO - 'NO_EM_RESTART': '1', 04:20:24 INFO - 'PAGER': '/bin/cat', 04:20:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:24 INFO - 'PWD': '/builds/slave/test', 04:20:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:24 INFO - 'SHELL': '/bin/bash', 04:20:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:24 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:24 INFO - 'USER': 'cltbld', 04:20:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:24 INFO - 'XPC_FLAGS': '0x0', 04:20:24 INFO - 'XPC_SERVICE_NAME': '0', 04:20:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:24 INFO - Downloading/unpacking psutil>=3.1.1 04:20:24 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 04:20:24 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 04:20:24 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 04:20:24 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 04:20:24 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 04:20:24 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 04:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:20:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:27 INFO - Installing collected packages: psutil 04:20:27 INFO - Running setup.py install for psutil 04:20:27 INFO - building 'psutil._psutil_osx' extension 04:20:27 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 04:20:28 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 04:20:28 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 04:20:28 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 04:20:28 INFO - building 'psutil._psutil_posix' extension 04:20:28 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 04:20:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:20:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:20:28 INFO - ^ 04:20:28 INFO - 1 warning generated. 04:20:28 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 04:20:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:20:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:20:28 INFO - Successfully installed psutil 04:20:28 INFO - Cleaning up... 04:20:28 INFO - Return code: 0 04:20:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:20:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:20:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:28 INFO - 'HOME': '/Users/cltbld', 04:20:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:28 INFO - 'LOGNAME': 'cltbld', 04:20:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:28 INFO - 'MOZ_NO_REMOTE': '1', 04:20:28 INFO - 'NO_EM_RESTART': '1', 04:20:28 INFO - 'PAGER': '/bin/cat', 04:20:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:28 INFO - 'PWD': '/builds/slave/test', 04:20:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:28 INFO - 'SHELL': '/bin/bash', 04:20:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:28 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:28 INFO - 'USER': 'cltbld', 04:20:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:28 INFO - 'XPC_FLAGS': '0x0', 04:20:28 INFO - 'XPC_SERVICE_NAME': '0', 04:20:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:20:29 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 04:20:29 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 04:20:29 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 04:20:29 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 04:20:29 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 04:20:29 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 04:20:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:20:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:20:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:20:31 INFO - Installing collected packages: mozsystemmonitor 04:20:31 INFO - Running setup.py install for mozsystemmonitor 04:20:31 INFO - Successfully installed mozsystemmonitor 04:20:31 INFO - Cleaning up... 04:20:31 INFO - Return code: 0 04:20:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:31 INFO - 'HOME': '/Users/cltbld', 04:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:31 INFO - 'LOGNAME': 'cltbld', 04:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:31 INFO - 'MOZ_NO_REMOTE': '1', 04:20:31 INFO - 'NO_EM_RESTART': '1', 04:20:31 INFO - 'PAGER': '/bin/cat', 04:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:31 INFO - 'PWD': '/builds/slave/test', 04:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:31 INFO - 'SHELL': '/bin/bash', 04:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:31 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:31 INFO - 'USER': 'cltbld', 04:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:31 INFO - 'XPC_FLAGS': '0x0', 04:20:31 INFO - 'XPC_SERVICE_NAME': '0', 04:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:32 INFO - Downloading/unpacking jsonschema==2.5.1 04:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:20:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:34 INFO - Downloading functools32-3.2.3-2.tar.gz 04:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:20:35 INFO - warning: no files found matching '*.txt' 04:20:35 INFO - no previously-included directories found matching 'build' 04:20:35 INFO - no previously-included directories found matching 'dist' 04:20:35 INFO - no previously-included directories found matching '.git*' 04:20:35 INFO - Installing collected packages: jsonschema, functools32 04:20:35 INFO - Running setup.py install for functools32 04:20:35 INFO - warning: no files found matching '*.txt' 04:20:35 INFO - no previously-included directories found matching 'build' 04:20:35 INFO - no previously-included directories found matching 'dist' 04:20:35 INFO - no previously-included directories found matching '.git*' 04:20:35 INFO - Successfully installed jsonschema functools32 04:20:35 INFO - Cleaning up... 04:20:35 INFO - Return code: 0 04:20:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:20:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:35 INFO - 'HOME': '/Users/cltbld', 04:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:35 INFO - 'LOGNAME': 'cltbld', 04:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:35 INFO - 'MOZ_NO_REMOTE': '1', 04:20:35 INFO - 'NO_EM_RESTART': '1', 04:20:35 INFO - 'PAGER': '/bin/cat', 04:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:35 INFO - 'PWD': '/builds/slave/test', 04:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:35 INFO - 'SHELL': '/bin/bash', 04:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:35 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:35 INFO - 'USER': 'cltbld', 04:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:35 INFO - 'XPC_FLAGS': '0x0', 04:20:35 INFO - 'XPC_SERVICE_NAME': '0', 04:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:20:35 INFO - Cleaning up... 04:20:35 INFO - Return code: 0 04:20:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:35 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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:35 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 04:20:35 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 04:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:35 INFO - 'HOME': '/Users/cltbld', 04:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:35 INFO - 'LOGNAME': 'cltbld', 04:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:35 INFO - 'MOZ_NO_REMOTE': '1', 04:20:35 INFO - 'NO_EM_RESTART': '1', 04:20:35 INFO - 'PAGER': '/bin/cat', 04:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:35 INFO - 'PWD': '/builds/slave/test', 04:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:35 INFO - 'SHELL': '/bin/bash', 04:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:35 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:35 INFO - 'USER': 'cltbld', 04:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:35 INFO - 'XPC_FLAGS': '0x0', 04:20:35 INFO - 'XPC_SERVICE_NAME': '0', 04:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 04:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:20:38 INFO - Downloading blobuploader-1.2.4.tar.gz 04:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:20:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 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 04:20:38 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 04:20:39 INFO - Downloading docopt-0.6.1.tar.gz 04:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:20:39 INFO - Installing collected packages: blobuploader, requests, docopt 04:20:39 INFO - Running setup.py install for blobuploader 04:20:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:20:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:20:39 INFO - Running setup.py install for requests 04:20:40 INFO - Running setup.py install for docopt 04:20:40 INFO - Successfully installed blobuploader requests docopt 04:20:40 INFO - Cleaning up... 04:20:40 INFO - Return code: 0 04:20:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:40 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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:40 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 04:20:40 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 04:20:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:40 INFO - 'HOME': '/Users/cltbld', 04:20:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:40 INFO - 'LOGNAME': 'cltbld', 04:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:40 INFO - 'MOZ_NO_REMOTE': '1', 04:20:40 INFO - 'NO_EM_RESTART': '1', 04:20:40 INFO - 'PAGER': '/bin/cat', 04:20:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:40 INFO - 'PWD': '/builds/slave/test', 04:20:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:40 INFO - 'SHELL': '/bin/bash', 04:20:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:40 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:40 INFO - 'USER': 'cltbld', 04:20:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:40 INFO - 'XPC_FLAGS': '0x0', 04:20:40 INFO - 'XPC_SERVICE_NAME': '0', 04:20:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:40 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-ba7awI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:40 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Pmp908-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:40 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-tcTHyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:40 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-_V25YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-nagBce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-uFrM4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-JJ2Czn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-Ir77g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-pOE1y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-YacUty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-SwQEWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-CwQWS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:41 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-4cVrPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:42 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-V6R2Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:42 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-d5D6_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:42 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-eEsmVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:42 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-EEtBIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:20:42 INFO - Running setup.py install for manifestparser 04:20:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:20:42 INFO - Running setup.py install for mozcrash 04:20:42 INFO - Running setup.py install for mozdebug 04:20:42 INFO - Running setup.py install for mozdevice 04:20:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Running setup.py install for mozfile 04:20:43 INFO - Running setup.py install for mozhttpd 04:20:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Running setup.py install for mozinfo 04:20:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Running setup.py install for mozInstall 04:20:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Running setup.py install for mozleak 04:20:43 INFO - Running setup.py install for mozlog 04:20:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:20:43 INFO - Running setup.py install for moznetwork 04:20:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:20:44 INFO - Running setup.py install for mozprocess 04:20:44 INFO - Running setup.py install for mozprofile 04:20:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:20:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:20:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:20:44 INFO - Running setup.py install for mozrunner 04:20:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:20:44 INFO - Running setup.py install for mozscreenshot 04:20:44 INFO - Running setup.py install for moztest 04:20:44 INFO - Running setup.py install for mozversion 04:20:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:20:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:20:45 INFO - Cleaning up... 04:20:45 INFO - Return code: 0 04:20:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:45 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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:45 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 04:20:45 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 04:20:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:45 INFO - 'HOME': '/Users/cltbld', 04:20:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:45 INFO - 'LOGNAME': 'cltbld', 04:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:45 INFO - 'MOZ_NO_REMOTE': '1', 04:20:45 INFO - 'NO_EM_RESTART': '1', 04:20:45 INFO - 'PAGER': '/bin/cat', 04:20:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:45 INFO - 'PWD': '/builds/slave/test', 04:20:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:45 INFO - 'SHELL': '/bin/bash', 04:20:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:45 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:45 INFO - 'USER': 'cltbld', 04:20:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:45 INFO - 'XPC_FLAGS': '0x0', 04:20:45 INFO - 'XPC_SERVICE_NAME': '0', 04:20:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:20:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-BNWlMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:20:45 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)) 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:20:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DT3GnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:20:45 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)) 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:20:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-xb0iq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:20:45 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)) 04:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:20:45 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-UgcUFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DhwT2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-oLn_eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-b_eFxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-aM0GZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DP9xqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-0ZZsU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-NuygsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-GxkSz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:20:46 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)) 04:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:20:46 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-OMZs4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:20:47 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)) 04:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:20:47 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-z7FlXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:20:47 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)) 04:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:47 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-yI9j1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:20:47 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)) 04:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:20:47 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-IWjnBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:20:47 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)) 04:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:20:47 INFO - Running setup.py (path:/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/pip-DNwD9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:20:47 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)) 04:20:47 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)) 04:20:47 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)) 04:20:47 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)) 04:20:47 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)) 04:20:47 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)) 04:20:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:20:47 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 04:20:47 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 04:20:47 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 04:20:47 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 04:20:47 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 04:20:47 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 04:20:50 INFO - Downloading blessings-1.6.tar.gz 04:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:20:50 INFO - Installing collected packages: blessings 04:20:50 INFO - Running setup.py install for blessings 04:20:50 INFO - Successfully installed blessings 04:20:50 INFO - Cleaning up... 04:20:50 INFO - Return code: 0 04:20:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:50 INFO - Reading from file tmpfile_stdout 04:20:50 INFO - Current package versions: 04:20:50 INFO - blessings == 1.6 04:20:50 INFO - blobuploader == 1.2.4 04:20:50 INFO - docopt == 0.6.1 04:20:50 INFO - functools32 == 3.2.3-2 04:20:50 INFO - jsonschema == 2.5.1 04:20:50 INFO - manifestparser == 1.1 04:20:50 INFO - mozInstall == 1.12 04:20:50 INFO - mozcrash == 0.17 04:20:50 INFO - mozdebug == 0.1 04:20:50 INFO - mozdevice == 0.48 04:20:50 INFO - mozfile == 1.2 04:20:50 INFO - mozhttpd == 0.7 04:20:50 INFO - mozinfo == 0.9 04:20:50 INFO - mozleak == 0.1 04:20:50 INFO - mozlog == 3.3 04:20:50 INFO - moznetwork == 0.27 04:20:50 INFO - mozprocess == 0.23 04:20:50 INFO - mozprofile == 0.28 04:20:50 INFO - mozrunner == 6.12 04:20:50 INFO - mozscreenshot == 0.1 04:20:50 INFO - mozsystemmonitor == 0.3 04:20:50 INFO - moztest == 0.7 04:20:50 INFO - mozversion == 1.4 04:20:50 INFO - psutil == 3.1.1 04:20:50 INFO - requests == 1.2.3 04:20:50 INFO - wsgiref == 0.1.2 04:20:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:50 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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:50 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 04:20:50 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 04:20:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:50 INFO - 'HOME': '/Users/cltbld', 04:20:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:50 INFO - 'LOGNAME': 'cltbld', 04:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:50 INFO - 'MOZ_NO_REMOTE': '1', 04:20:50 INFO - 'NO_EM_RESTART': '1', 04:20:50 INFO - 'PAGER': '/bin/cat', 04:20:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:50 INFO - 'PWD': '/builds/slave/test', 04:20:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:50 INFO - 'SHELL': '/bin/bash', 04:20:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:50 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:50 INFO - 'USER': 'cltbld', 04:20:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:50 INFO - 'XPC_FLAGS': '0x0', 04:20:50 INFO - 'XPC_SERVICE_NAME': '0', 04:20:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 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)) 04:20:51 INFO - Cleaning up... 04:20:51 INFO - Return code: 0 04:20:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:20:51 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 0x1034dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103573618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4d254df00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, '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.fXXpEJAFsl/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.arG9yPVGUw/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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 04:20:51 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 04:20:51 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 04:20:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:20:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:20:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:20:51 INFO - 'HOME': '/Users/cltbld', 04:20:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:20:51 INFO - 'LOGNAME': 'cltbld', 04:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:51 INFO - 'MOZ_NO_REMOTE': '1', 04:20:51 INFO - 'NO_EM_RESTART': '1', 04:20:51 INFO - 'PAGER': '/bin/cat', 04:20:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:51 INFO - 'PWD': '/builds/slave/test', 04:20:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:20:51 INFO - 'SHELL': '/bin/bash', 04:20:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:20:51 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:20:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:20:51 INFO - 'USER': 'cltbld', 04:20:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:20:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:51 INFO - 'XPC_FLAGS': '0x0', 04:20:51 INFO - 'XPC_SERVICE_NAME': '0', 04:20:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:20:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:20:51 INFO - Cleaning up... 04:20:51 INFO - Return code: 0 04:20:51 INFO - Running post-action listener: _resource_record_post_action 04:20:51 INFO - Running post-action listener: _start_resource_monitoring 04:20:51 INFO - Starting resource monitoring. 04:20:51 INFO - [mozharness: 2016-08-08 11:20:51.464384Z] Finished create-virtualenv step (success) 04:20:51 INFO - [mozharness: 2016-08-08 11:20:51.465380Z] Running install step. 04:20:51 INFO - Running pre-action listener: _resource_record_pre_action 04:20:51 INFO - Running main action method: install 04:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:20:51 INFO - Reading from file tmpfile_stdout 04:20:51 INFO - Detecting whether we're running mozinstall >=1.0... 04:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:20:51 INFO - Reading from file tmpfile_stdout 04:20:51 INFO - Output received: 04:20:51 INFO - Usage: mozinstall [options] installer 04:20:51 INFO - Options: 04:20:51 INFO - -h, --help show this help message and exit 04:20:51 INFO - -d DEST, --destination=DEST 04:20:51 INFO - Directory to install application into. [default: 04:20:51 INFO - "/builds/slave/test"] 04:20:51 INFO - --app=APP Application being installed. [default: firefox] 04:20:51 INFO - mkdir: /builds/slave/test/build/application 04:20:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:20:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:21:26 INFO - Reading from file tmpfile_stdout 04:21:26 INFO - Output received: 04:21:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:21:26 INFO - Running post-action listener: _resource_record_post_action 04:21:26 INFO - [mozharness: 2016-08-08 11:21:26.470557Z] Finished install step (success) 04:21:26 INFO - [mozharness: 2016-08-08 11:21:26.470705Z] Running run-tests step. 04:21:26 INFO - Running pre-action listener: _resource_record_pre_action 04:21:26 INFO - Running main action method: run_tests 04:21:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:21:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:21:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:21:26 INFO - 2016-08-08 04:21:26.485 screenresolution[1661:7433] starting screenresolution argv=screenresolution get 04:21:26 INFO - 2016-08-08 04:21:26.487 screenresolution[1661:7433] Display 0: 1600x1200x32@60 04:21:26 INFO - 2016-08-08 04:21:26.493 screenresolution[1662:7435] starting screenresolution argv=screenresolution list 04:21:26 INFO - Available Modes on Display 0 04:21:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:21:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:21:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:21:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:21:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:21:26 INFO - Intel Iris: 04:21:26 INFO - Chipset Model: Intel Iris 04:21:26 INFO - Type: GPU 04:21:26 INFO - Bus: Built-In 04:21:26 INFO - VRAM (Dynamic, Max): 1536 MB 04:21:26 INFO - Vendor: Intel (0x8086) 04:21:26 INFO - Device ID: 0x0a2e 04:21:26 INFO - Revision ID: 0x0009 04:21:26 INFO - Displays: 04:21:26 INFO - Display: 04:21:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:21:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:21:26 INFO - Display Serial Number: 1600x1200 60 04:21:26 INFO - Main Display: Yes 04:21:26 INFO - Mirror: Off 04:21:26 INFO - Online: Yes 04:21:26 INFO - Rotation: Supported 04:21:26 INFO - Return code: 0 04:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:21:26 INFO - Python 2.7.3 04:21:26 INFO - Return code: 0 04:21:26 INFO - grabbing minidump binary from tooltool 04:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:26 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 0x103442d30>, '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 0x1031a7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10343ab20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:21:26 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 04:21:26 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 04:21:26 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 04:21:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:21:26 INFO - Return code: 0 04:21:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:21:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:21:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:21:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:21:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:21:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:21:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXXpEJAFsl/Render', 04:21:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:21:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:21:26 INFO - 'HOME': '/Users/cltbld', 04:21:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:21:26 INFO - 'LOGNAME': 'cltbld', 04:21:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:21:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:21:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:26 INFO - 'MOZ_NO_REMOTE': '1', 04:21:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:21:26 INFO - 'NO_EM_RESTART': '1', 04:21:26 INFO - 'PAGER': '/bin/cat', 04:21:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:21:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:26 INFO - 'PWD': '/builds/slave/test', 04:21:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:21:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:21:26 INFO - 'SHELL': '/bin/bash', 04:21:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arG9yPVGUw/Listeners', 04:21:26 INFO - 'TMPDIR': '/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/', 04:21:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:21:26 INFO - 'USER': 'cltbld', 04:21:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:21:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:21:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:26 INFO - 'XPC_FLAGS': '0x0', 04:21:26 INFO - 'XPC_SERVICE_NAME': '0', 04:21:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:21:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:21:27 INFO - mozversion application_buildid: 20160808012421 04:21:27 INFO - mozversion application_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 04:21:27 INFO - mozversion application_display_name: Nightly 04:21:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:21:27 INFO - mozversion application_name: Firefox 04:21:27 INFO - mozversion application_remotingname: firefox 04:21:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:21:27 INFO - mozversion application_vendor: Mozilla 04:21:27 INFO - mozversion application_version: 51.0a1 04:21:27 INFO - mozversion platform_buildid: 20160808012421 04:21:27 INFO - mozversion platform_changeset: f8fc21bb232095b7b4c995d259558212cb90a44b 04:21:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:21:27 INFO - mozversion platform_version: 51.0a1 04:21:27 INFO - using testdate: 1470655287 04:21:27 INFO - actual date: 1470655287 04:21:27 INFO - starting webserver on 'localhost:49280' 04:21:27 INFO - SUITE-START | Running 2 tests 04:21:27 INFO - TEST-START | dromaeo_css 04:21:27 INFO - operating with platform_type : mac_ 04:21:27 INFO - Initialising browser for dromaeo_css test... 04:21:27 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpke7zzp/profile http://localhost:49280/getInfo.html) 04:21:29 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 04:21:29 INFO - PROCESS | 1672 | colorDepth:24 04:21:29 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 04:21:29 INFO - PROCESS | 1672 | __metrics 04:21:29 ERROR - PROCESS | 1672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:21:30 INFO - TEST-INFO | 1672: exit 0 04:21:30 INFO - Browser initialized. 04:21:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:21:30 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpke7zzp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:21:42 INFO - PROCESS | 1675 | RSS: Main: 254738432 04:21:42 INFO - PROCESS | 1675 | 04:22:32 INFO - PROCESS | 1675 | 1470655352137 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] 04:24:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 04:24:46 INFO - PROCESS | 1675 | RSS: Main: 268029952 04:24:46 INFO - PROCESS | 1675 | 04:27:49 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 04:27:49 INFO - PROCESS | 1675 | RSS: Main: 282112000 04:27:49 INFO - PROCESS | 1675 | 04:30:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 04:30:52 INFO - PROCESS | 1675 | RSS: Main: 289288192 04:30:52 INFO - PROCESS | 1675 | 04:33:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 04:33:54 INFO - PROCESS | 1675 | RSS: Main: 288935936 04:33:54 INFO - PROCESS | 1675 | 04:36:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 04:36:58 INFO - PROCESS | 1675 | RSS: Main: 292966400 04:36:58 INFO - PROCESS | 1675 | 04:40:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 04:40:01 INFO - PROCESS | 1675 | RSS: Main: 292872192 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | __start_tp_report 04:40:01 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 04:40:01 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 04:40:01 INFO - PROCESS | 1675 | |i|pagename|runs| 04:40:01 INFO - PROCESS | 1675 | |0;dojo.html;3366.2594229269553;3388.220709236876;3404.3872103021463;3415.5559777228955;3422.4524076147823;4457.821687132511;5009.749512524369;5098.949010509889;5620;5722.399148089448;5459.945400545993;5478.260434841295;5724.942750572493;5731.254936858213;5740.56945729071;4518.344839998198;5150.922736158961;5238.607104467161;5264.763085661135;5301.867453313659;5294.814681486148;5343.893122137555;5360.812371566996;5397.62216644835;5414.296141501619;5163.741812909377;5191.506806853343;5224.921626175629;5257.605679574009;5295;5252.9737351313;5253.553447956928;5272.868178295535;5276.472352764731;5303.840884773463;5188.247704082924;5192;5252.973735131338;5270.736463176864;5274.472552744734;4496.820127194908;5629.549636029149;5658.207850900877;5688.658680479184;5695.686737229451;6212.316645169028;6214.937850621526;6265.655388953652;6284.088807122987;6294.307626161119;6255.155554000243;6273.811785646438;6294.402031806971;6297.2128483939505;6306.558540902139;5711.685857277848;5800.50695690871;5833.533317334645;5847;5867.2959244890035;6284.497240220771;6288.056791481315;6288.748450061947;6305.432511074026;6319.494440444753;6187.566870319124;6188.907166392508;6207.410296021871;6212.161358216673;6229.688515574203;6109.419605137505;6120.965252118766;6164.938350616437;6197.349278325711;6204.875902481925;6221.471174950089;6225.470834978987;6240.469560087444;6244.469220116341;6253.155823963798;4662.790174442158;4988.925166122511;6251.624902505773;6258.812235632939;6262.9666105093065;4878.365812444359;4949.084419382426;4969.627277954168;4972.67677600962;4978.103941290602;4467.687261891701;4473.955260447354;4481.574250446268;4504.774761261924;4516.345129956138;5680.0627896397455;5767.8558036049435;5768.2501274834;5772.220750198753;5778.971105144531;5336.039512887717;6014.36849130835;6176.69116544171;6181.690915454299;6255.218097737783;4587.977060114678;5771.711414429262;5794.681292528867;5847.38602446737;5864.589478736533;5451.890962180734;5463.125899856004;5490.423505531941;5512.724363781795;5529.253550770675;6179.505639548735;6229.719662615284;6350.428461438492;6362.141110949962;6385.936140638627;6219.40915613016;6247.187865577446;6266.655333956676;6275.466585340298;6278.340774218641;6236.438720515175;6330.8100756977365;6335.968320158554;6340.841478963062;6356.555041147075;6053.334133245427;6098.613770999223;6133.662648554372;6168.629882207082;6186;5320.920186197288;5909.6158749681135;6209.5032397409;6216.409441103269;6251.99968005117;6170.136180934583;6175.44421002112;6175.9073613894925;6178.9382106180165;6186.4741496973265;5610.13042978339;5937.406259374028;6085.786997455068;6158.168647232566;6180.7527698891545;5888.4700376966275;5968.492678122235;6006.189164462741;6077.513798896166;6095.085737139465;6164.969175154096;6178.845528861814;6184.659843708459;6186.752529898934;6214.782482613087;5846.298444186555;5959.553033522417;6002.159697642246;6031.728572214349;6049.909251361321 04:40:01 INFO - PROCESS | 1675 | |1;ext.html;454.7748864312166;539.3689383421397;540.087252543202;549.6866785932018;552.4806681719186;31451.68548314516;40101.59898401012;40119.79940100303;40120.99697507556;40175.59824401755;32766.508502372482;35447;40368.59631403685;40840.57058002971;41096;9348.626054957793;9411.341206115574;9498.952505237465;9556.61773529058;9614.086661767122;8114.756557303261;8143.674253029872;9543.713688589318;9543.761405964871;9579.377340472882;9566;9576.138147566717;9587.376820506679;9603.791128040555;9618.182454491376;8401.327893768514;8976.8653470198;9550.61797528098;9594.42433453995;9608.327417080807;9413.435193888388;9493.335466517347;9519.714838496784;9520.619175233052;9522.333436659437;38737.61262387368;38907.805460972515;39038.80480597607;39132.80433597814;39180.412293815614;2880.6399200099986;3076;3374.295372097985;3379.8986030418882;3517.964820351815;29483.557746633818;29718.70281297181;29730.662120204644;29743.70256297431;30332.241693957607;3087;3087.536869469575;3115.8597863096215;3137.090243829287;3234.87060517579;405240;412847;416151;416391;419221;32656.673433265838;32708.67291327104;32813.343733125206;32818;32942.67057329444;33693.83153084219;33729;33797.83101084479;35094.649053509645;35265.47101793475;15904.76142857858;16012.199390030451;16012.799040071808;16057.919710401608;16063.277152528164;12264.080193985486;12365.319907404999;12411.441485133191;12412.75174496505;12444.875551244371;18568.25726970933;18743.906280468782;18769;18868.716969245474;18937.715934260996;6433.420992110732;7772.261635144652;7810.414218933603;7882.605869706606;7918.406119541058;887.8179973105498;970.2819913264275;983.341161421849;1001.9699409017741;1014.4674046125843;26398.736012640013;27195.456090878466;27372.45255094887;29710.55434168446;30460.847695761822;1013.6300250408548;1061.2518174686827;1079.0935614084208;1083.2417307884512;1095.2771171027243;13181.406836692371;14903.105813650998;15110.773338399933;15165.924170379078;15241.390344386322;523768.905777351;613475;617075;622657;622769;54302;54605.45394546004;54697.45302547003;54882;55006.72496637491;1336.6457888659513;1370.0751992405087;1395.0653062448184;1400.7758758598575;1403.0669604712753;22905.19831805879;28169.295767605974;28426.715732842407;28672;28950.565741514314;39212.01969950774;48197.75901120472;48833;49233.507664922894;49557;575226;575970;577098;580507;581077;22448.887755561773;25780.09769658053;26013.21960341193;26182.34544136412;26270.343241419116;43339;45856.31215531703;47713;47965.5203447961;48291;32821.05881123802;38604.6139538601;39189.216215674955;40025.399619005155;40386;39283.41074883822;39532.40701389539;39660.80169599134;40741.59258407496;40907;32376.838115810213;37339.43990840194;37791.244175116895;37860.62139378571;37996.2400751989;28101.578476322462;33398.332033359686;34287.82856085704;34454.48318275278;34583.308333832676;25314.873425632755;25500.617490738026;25927.611085834105;26060.34849128787;26370.736292637597 04:40:01 INFO - PROCESS | 1675 | |2;jquery.html;342.4401104194642;359.60802725029714;368.3939918833519;385.76468354303853;394.91509325495014;20229.898850505746;20258.797412025877;21382.99999999998;21597.244096456627;21654.675179872276;19070.427887163372;20466.38600841977;21048.89475552624;21166.788332116674;21235.239418875564;4970.776315065813;5604.523615492668;5789.855253618673;6014.729337179838;6027.397260273981;5965.164876917235;6002.819915402545;6005.579609427342;6018.488428483584;6048.788292409767;5779.104238842986;5811.360750317462;5853.975554278006;5916.437938395846;5988.071848863411;5995.4304341087745;6022.96988515059;6026.674131691021;6029.69851507425;6056.152138700585;5131.923021154686;5408.513233808937;5411.161270003156;5490.505854473116;5522.641028333145;13040.413181406859;13098.214107153506;13144.60566183016;13189.736205275936;13418.396172172275;2075.9065842037144;2154.310620601408;2168.1435832846096;2479.454520005596;2730.6586676665415;8007.95996020022;9886.752831179207;9955.054269844426;10338.431386273753;10393.012663796928;1749.3177660712333;1811.4384540792264;1840.3006857394105;1851.583393736412;1897.7627796525435;110121;115364.42317788357;128767.71232287651;129709;131600.3419982894;9043.59303831329;11536.480858361394;11557;11565.884341156649;11757.470913808898;12795.61613151607;13554.322283885964;14057.086289391156;14394.928025360015;14417.711645767236;8247.793805154919;8522.190391912758;8556.700515481929;8628.396012279205;8641.567921603895;8504.44721093127;8513.276371508491;8514.616842242114;8584.656613735506;8707.042225355206;4446.2663660495655;4451.465824101064;4487.461504619401;4565.292379681155;4579.931301030487;1644.0300222868566;1881.5484283771796;1892.3093071028975;1932.8743631664179;1943.7181608666665;757.4811254290828;822.9094799572042;870.5995242188537;919.5678031325266;964.4695417520336;20011.699824502353;20891.059902304434;21138.682919756215;21361.415936246955;21522.246721364678;907.8728977943093;911.5077857956762;963.3738070254251;967.937084089546;1021.1881554164457;9284.582193801296;10045.69862904114;11158.665240042812;11179.83230251547;11185.776284474265;543858;562620.1868990628;570817;587092;591058;96880;106742.46628766807;110288.4485577567;130682;138169;895.1943251073956;975.0785507695301;981.1807141037314;1021.3769600543662;1023.2632504596678;15115.470958516398;17624.942503449834;19201.32795352156;19268.903655482194;19352.8064719351;35471.29057418786;39568;47776.04447910953;53746.65633359041;55166.44833551613;53765;81511;83255.583722081;84033;84304.73542896984;6414.10202571631;6640.402363787282;6824.317568243136;7612.048493938258;8100.918990810016;10789.949909517167;11083;12909;12992.415341309475;13798.586042418743;11493.252938558968;11540.596079137189;11923.165378423773;12056.397180141134;12089.032877369966;10658.467076646291;11340.6030788922;11655.53377864876;11740.41297935117;11955.103367247317;7076.893846592408;11264.493097810782;11834.704132396759;11920.225185362924;11949.701257468632;8222.876656850272;8447.408681392244;8519.105493923296;8551.828963420821;8576.528290943808;5483.369412517612;8706.347023973101;8965.50689712072;11604.187706860777;11728.712900984567 04:40:01 INFO - PROCESS | 1675 | |3;mootools.html;1455.0614853419543;1500.4448354108981;1671.5988162840922;1781.7238328059154;1783.1440908363984;7776.9222307777045;8356;8369.83260334793;8883.067277935812;8886.289096872251;8539.530325832093;8543.78640533987;8718.084601116887;8749.562521873913;8764.605592748325;2335.789778919897;2370.8221883358733;2380.2621187431864;2384.332386931662;2394.1261439574605;1905.9142338594727;2298.5632729781373;2364.7517010713887;2365.7042869641296;2373.52529494101;2020.070767446976;2337.4506990857135;2347.448349637834;2355.5171189906027;2375.893084811179;2062.484378905274;2255.379770563092;2316.8262380321544;2338.169949667869;2346.8474549154253;2345.6598793174894;2348.03730470508;2350.5886469867874;2354.835161538693;2359.3275916363928;8245.628946697412;8397.076321604618;8408.747737567883;8475.813386125947;8503.277221436185;5138.537531622172;5231.581473482112;5284.788608455658;5307.548858347045;5317.2821669074565;3425.7088147507493;3468.358353704573;3541.1855273287288;3555.6532688425773;3644.0889777555612;1092.579356947573;1108.3349990006013;1780.652772709322;1844.97232541512;1899.8005209452947;9095.909040909572;11299.039581635489;11488.597899073493;11505.5973040944;11570.247933884355;3844.7693138411787;4339.153864996359;4399.472063352354;4557.453105627346;4559.6808223424705;7695.6152192390155;9094.636214551476;9095.36332456735;9096.408733432438;9119.498427586546;5139.434662187156;5144.048351055067;5147.330846989942;5150.201718733602;5156.226566015052;4347.847825326162;4550.795214215368;4745.074710431501;4767.189577771718;4841.491643377465;3819.8472061117245;3871.7870517121264;3885.4171874218528;4021.7989100544855;4056.2698714231133;1265.3167289663663;1287.2083668543778;1292.3473645808995;1308.3196737696535;1311.1608570514877;796.2596619614872;859.9699010534601;900.1133883125117;937.0067728207985;964.2671569607149;4754.857354279377;5658.405867383865;5759;5832.24180856486;6046.3046749624355;428.67420760222456;446.2458445227555;448.7957979119493;453.09833431471793;455.5285279735458;3532.3111993161087;3993.72043956926;4114.876553703393;4116.341385378325;4150.149219410074;10129;10576.788464230673;10605.681829545127;10606.469676516297;10609.575616975235;10388.688339349832;10490.790184196274;10548.947255263674;10559;10564.841527377095;6856.348646878539;7336.816579585553;7913.406494512935;8149.674013039412;8171.346292296602;5804.477597016289;5860.355360910211;5972.402759723993;5975.492083172979;6007.609505382136;9799.85300220483;9911.058449447291;9913.355631883904;9922.206223501958;9930;8092.595370231583;10000.24998125129;10010.849837252592;10096.798064038825;10127.7468063299;6304.65324407162;6909.205441374306;7289.307515785992;7475.177730449537;7584.165741768511;7074.186468556182;8400.537970411686;8401.495910245405;8408.117147699404;8414.200650938152;7438.107427108782;7530.397568194422;7582.090149182133;7653.693852245848;7663.27198916102;7387.372073373608;7401.370883474965;7424.628768561658;7566.9784579081115;7585.165631780389;6887.483438742014;7002.2647622000995;7004.929950700632;7026.1217347831525;7035.964820175866;4901.754912254444;4978.029284289529;5063.265826455217;5080.872978175576;5119.846404607719;4704.741239231875;4980.352554167935;5041.117804384145;5130.538251557377;5205.568468671146 04:40:01 INFO - PROCESS | 1675 | |4;prototype.html;286.65744435399694;297.3072740514601;310.6055309756608;311.82070309572003;315.4920577869631;5075.593952483801;5445.9727701361535;5600.859978500534;5679.182661548301;5706.942930570693;5162.045021670993;5457.918131228025;5578.581606379517;5592.7762889484475;5600.235925683407;3522.771019883712;3704.6292871637397;4277.315629499289;4282.828686852522;4299.355096735483;4150.97924510377;4177.17426446816;4224.049588842517;4251.128518653669;4332.631726303252;3429.9828500857584;3838.539375274971;4016.7748836604824;4189.779416909043;4204.852830150945;3833.0225792422752;4196.727212731178;4215.768132752697;4229.963658903573;4284.67864910133;3614.6083757753454;3683.226522430293;3684.778913265186;3685.7836913818373;3706.721995850322;4113.321301985169;4139.503259608866;4295.871123866289;4806.903861922777;5011.291644183279;3909.706771992112;4573.588377046049;4652.8138874444985;4681.765911704401;4850.53919877611;5087.440381558025;5582.525485333752;5648.519875810561;5700.486956173964;5965.970170149121;3340.816255105968;3613.3676606594004;3984.3824207247635;3985.362342025262;4017.196560687874;6208.192934918477;6231.130660801741;6234.875302493925;6250.718717657671;6278.654673992928;3853.7687738735767;4075.775832329191;4108.198901214235;4108.801791041778;4111.218868414991;3783.6783873371073;3962.663173630216;4141.7722025288895;4151.958480415217;4155.688323375759;4043.1509383029306;4736.455307639666;4822.95177048232;4842.225243960949;4884.926726099111;5091.541761241432;5245.318108645928;5400.351957765015;5471.6169868108855;5944.613600115978;1242.4655550395255;1336.565616174747;1415.9221242831743;1424.223798030076;1426.3866537388815;946.9810603787886;957.5738796235747;970.3110791338088;971.3152227679469;986.6250824686573;5083.415407228142;5201.219817027476;5462.863428414322;5479.835604931858;5484.2596249505805;5244.5279924806955;5490.858565159591;6032.276126864805;6061.7575296987625;6064.545159112996;5008.924866127011;5018.573421259161;5288.497592728685;5428.945710542923;5474.835754927359;2663.2942270298386;2705.2830999785074;2707.837529748221;2719.6600424946882;2730.9726902731118;4527.411436513298;4532.682712210114;4863.61387004709;5013.473585273567;5339.546138578186;4478.888027799266;4790.329353890458;4898.828541001048;5165.358422312261;5218.547282777089;4245.936310955338;4479.529649386767;4858.46556878743;5243.632945693765;5297.867553311198;4202.243596152722;4540.795664195185;5088.430342676925;5159.742012899265;5186.766595503287;4168.458100446923;4309.482862056573;4788.079271644364;5058.671186372874;5083.92374114396;4231.3821682462285;4448.687637146984;4694;4914.287428322802;5286.524212820865;3185.5221716742676;3190.633077196152;3231.579894613685;3476.774009689362;3544.9291014179057;3955.4857868476915;4519.209138400701;4610.124076425468;4720.598749106364;5062;4280.336547835091;4520.3500722235485;4600.470945841271;4638.005657567279;4659.038124397506;4381.145676593033;4613.792379342871;4686.984596623484;4821.408935051495;4968.875778105432;4385.605295523418;4497.910041799211;4566.018306064212;4712.59942904857;4832.95167048325;3878.7090968178063;4121.649659778953;4584.610308123847;4853.927191092207;4946.15915294408;4001.7198796083994;4738.336632871332;4745.6746194365205;4925.9014819704125;4926.852194434173 04:40:01 INFO - PROCESS | 1675 | |5;yui.html;630.0612087988895;704.8167476456122;742.624974387934;762.6644276518333;785.9743035338884;12016.699582510431;12762.361881905914;15490;15617.84382156178;15708.293126809293;13836.446542138328;14180.929095354535;14218.502352417667;14263.286835658228;14267;682.4676752133344;840.0885039731899;844.7972486603232;869.7303835810919;869.8782170496136;872.4808738800403;873.9905409252292;874.0996773323487;876.0844917061686;876.5617191404298;884.7168905950099;923.9214666753334;924.2282693950559;924.3113880159257;925.4123631493983;868.8783570300163;877.6445539556458;890.412327863607;923.727500387384;923.8244733500613;670.6244503078292;683.8016975077221;685.2804555217002;685.5954986557955;689.0835189198355;13555.186688798703;13721.039527232997;13725.176489410667;13738.931305343509;13743.244121573309;11703.53185872564;11929.940350298193;13334.866651333556;14030.94767892402;14777.482788102365;11773.823392649118;11830.231034982784;11918.821217681741;11988.760224795455;12348.938255308756;3623.1304486923214;3874.2057878134915;3881.6894648428056;3983.223271462066;4006.3790112532606;103316;105306;106997.46501267522;107001;107310.46344768227;10621.787564248672;11301;11387.430628468543;11604.651860444032;11859.300473002273;20146.294879679142;21554;22133.557328853654;22844.200452984067;22887.656685149737;8107.635156417975;8195.42632015765;8280.213379728915;8357.58212089393;8410.453320534269;4519.796609152596;4602.217623004098;4612.423447069116;4649.581537661559;4803.519648035239;3560.946585801215;3672.779633222015;3685.5024571683016;3686.2258925625383;3686.3733165361955;634.508256101525;645.9677016149174;657.2769953051701;659.4394764450179;671.4963777167125;525.7975679363396;614.2199406753398;666.3303380102966;689.3224646510821;710.4884483172108;9062.549992001248;9602.66390676323;9647.276454265959;9697.709068727949;9745.415275083518;572.7165053298561;626.8683576448997;652.6964961293022;668.6188872342815;699.478888228263;4513.932291015637;4658.231391820312;4768.403949506312;4854.897611518261;4910.680805747615;101176.49411753041;101934;120735;121496;140846;140304;141622;142093.5790642101;143258;145075.46661612173;94260.5860912087;95839.52080239553;97011.54482682624;100337;111585;9775.608975640895;9820.4107753535;10099.798004040025;10123.898761012295;10157.542910568895;59168.81662366815;59973.80052399015;64754.67622661857;66616.33383666101;68433.63132737218;89014.55492722495;95958;96294;97568.51215743876;99005.50497247468;12700.806699675564;12959.222446653232;13118.934405327913;13188.670283242996;13641.522546710818;14942.327595258457;15074.849251507345;15086.471973480875;15111.319990600668;15193.316300766714;13634.727305453636;13686.384112715152;13697.315134243447;13766.380512877146;13907.652308692364;12410.5656302029;13715.314234288446;13864.86135138676;14320.57038288853;14437.06159099655;10809.82080982106;13766.380512876744;13806.447742090204;13842.238676872466;14029.929850350683;11284.21010529255;11410.94294528522;11491.138164637518;11505.194636375709;11902.583409580624;9229.446233226028;9948.651797187063;10142;10245.538950747085;10293.125084367912 04:40:01 INFO - PROCESS | 1675 | __end_tp_report 04:40:01 INFO - PROCESS | 1675 | __start_cc_report 04:40:01 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,421 04:40:01 INFO - PROCESS | 1675 | __end_cc_report 04:40:01 INFO - PROCESS | 1675 | __startTimestamp1470656401237__endTimestamp 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | ------- Summary: start ------- 04:40:01 INFO - PROCESS | 1675 | Number of tests: 6 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | [#0] dojo.html Cycles:165 Average:5707.52 Median:5909.62 stddev:661.06 (11.2%) stddev-sans-first:637.06 04:40:01 INFO - PROCESS | 1675 | Values: 3366.3 3388.2 3404.4 3415.6 3422.5 4457.8 5009.7 5098.9 5620.0 5722.4 5459.9 5478.3 5724.9 5731.3 5740.6 4518.3 5150.9 5238.6 5264.8 5301.9 5294.8 5343.9 5360.8 5397.6 5414.3 5163.7 5191.5 5224.9 5257.6 5295.0 5253.0 5253.6 5272.9 5276.5 5303.8 5188.2 5192.0 5253.0 5270.7 5274.5 4496.8 5629.5 5658.2 5688.7 5695.7 6212.3 6214.9 6265.7 6284.1 6294.3 6255.2 6273.8 6294.4 6297.2 6306.6 5711.7 5800.5 5833.5 5847.0 5867.3 6284.5 6288.1 6288.7 6305.4 6319.5 6187.6 6188.9 6207.4 6212.2 6229.7 6109.4 6121.0 6164.9 6197.3 6204.9 6221.5 6225.5 6240.5 6244.5 6253.2 4662.8 4988.9 6251.6 6258.8 6263.0 4878.4 4949.1 4969.6 4972.7 4978.1 4467.7 4474.0 4481.6 4504.8 4516.3 5680.1 5767.9 5768.3 5772.2 5779.0 5336.0 6014.4 6176.7 6181.7 6255.2 4588.0 5771.7 5794.7 5847.4 5864.6 5451.9 5463.1 5490.4 5512.7 5529.3 6179.5 6229.7 6350.4 6362.1 6385.9 6219.4 6247.2 6266.7 6275.5 6278.3 6236.4 6330.8 6336.0 6340.8 6356.6 6053.3 6098.6 6133.7 6168.6 6186.0 5320.9 5909.6 6209.5 6216.4 6252.0 6170.1 6175.4 6175.9 6178.9 6186.5 5610.1 5937.4 6085.8 6158.2 6180.8 5888.5 5968.5 6006.2 6077.5 6095.1 6165.0 6178.8 6184.7 6186.8 6214.8 5846.3 5959.6 6002.2 6031.7 6049.9 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | [#1] ext.html Cycles:180 Average:64830.22 Median:38300.43 stddev:143814.65 (375.5%) stddev-sans-first:144136.86 04:40:01 INFO - PROCESS | 1675 | Values: 454.8 539.4 540.1 549.7 552.5 31451.7 40101.6 40119.8 40121.0 40175.6 32766.5 35447.0 40368.6 40840.6 41096.0 9348.6 9411.3 9499.0 9556.6 9614.1 8114.8 8143.7 9543.7 9543.8 9579.4 9566.0 9576.1 9587.4 9603.8 9618.2 8401.3 8976.9 9550.6 9594.4 9608.3 9413.4 9493.3 9519.7 9520.6 9522.3 38737.6 38907.8 39038.8 39132.8 39180.4 2880.6 3076.0 3374.3 3379.9 3518.0 29483.6 29718.7 29730.7 29743.7 30332.2 3087.0 3087.5 3115.9 3137.1 3234.9 405240.0 412847.0 416151.0 416391.0 419221.0 32656.7 32708.7 32813.3 32818.0 32942.7 33693.8 33729.0 33797.8 35094.6 35265.5 15904.8 16012.2 16012.8 16057.9 16063.3 12264.1 12365.3 12411.4 12412.8 12444.9 18568.3 18743.9 18769.0 18868.7 18937.7 6433.4 7772.3 7810.4 7882.6 7918.4 887.8 970.3 983.3 1002.0 1014.5 26398.7 27195.5 27372.5 29710.6 30460.8 1013.6 1061.3 1079.1 1083.2 1095.3 13181.4 14903.1 15110.8 15165.9 15241.4 523768.9 613475.0 617075.0 622657.0 622769.0 54302.0 54605.5 54697.5 54882.0 55006.7 1336.6 1370.1 1395.1 1400.8 1403.1 22905.2 28169.3 28426.7 28672.0 28950.6 39212.0 48197.8 48833.0 49233.5 49557.0 575226.0 575970.0 577098.0 580507.0 581077.0 22448.9 25780.1 26013.2 26182.3 26270.3 43339.0 45856.3 47713.0 47965.5 48291.0 32821.1 38604.6 39189.2 40025.4 40386.0 39283.4 39532.4 39660.8 40741.6 40907.0 32376.8 37339.4 37791.2 37860.6 37996.2 28101.6 33398.3 34287.8 34454.5 34583.3 25314.9 25500.6 25927.6 26060.3 26370.7 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | [#2] jquery.html Cycles:180 Average:33462.19 Median:364.00 stddev:95566.62 (26254.5%) stddev-sans-first:95802.35 04:40:01 INFO - PROCESS | 1675 | Values: 342.4 359.6 368.4 385.8 394.9 20229.9 20258.8 21383.0 21597.2 21654.7 19070.4 20466.4 21048.9 21166.8 21235.2 4970.8 5604.5 5789.9 6014.7 6027.4 5965.2 6002.8 6005.6 6018.5 6048.8 5779.1 5811.4 5854.0 5916.4 5988.1 5995.4 6023.0 6026.7 6029.7 6056.2 5131.9 5408.5 5411.2 5490.5 5522.6 13040.4 13098.2 13144.6 13189.7 13418.4 2075.9 2154.3 2168.1 2479.5 2730.7 8008.0 9886.8 9955.1 10338.4 10393.0 1749.3 1811.4 1840.3 1851.6 1897.8 110121.0 115364.4 128767.7 129709.0 131600.3 9043.6 11536.5 11557.0 11565.9 11757.5 12795.6 13554.3 14057.1 14394.9 14417.7 8247.8 8522.2 8556.7 8628.4 8641.6 8504.4 8513.3 8514.6 8584.7 8707.0 4446.3 4451.5 4487.5 4565.3 4579.9 1644.0 1881.5 1892.3 1932.9 1943.7 757.5 822.9 870.6 919.6 964.5 20011.7 20891.1 21138.7 21361.4 21522.2 907.9 911.5 963.4 967.9 1021.2 9284.6 10045.7 11158.7 11179.8 11185.8 543858.0 562620.2 570817.0 587092.0 591058.0 96880.0 106742.5 110288.4 130682.0 138169.0 895.2 975.1 981.2 1021.4 1023.3 15115.5 17624.9 19201.3 19268.9 19352.8 35471.3 39568.0 47776.0 53746.7 55166.4 53765.0 81511.0 83255.6 84033.0 84304.7 6414.1 6640.4 6824.3 7612.0 8100.9 10789.9 11083.0 12909.0 12992.4 13798.6 11493.3 11540.6 11923.2 12056.4 12089.0 10658.5 11340.6 11655.5 11740.4 11955.1 7076.9 11264.5 11834.7 11920.2 11949.7 8222.9 8447.4 8519.1 8551.8 8576.5 5483.4 8706.3 8965.5 11604.2 11728.7 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | [#3] mootools.html Cycles:180 Average:5573.60 Median:4939.89 stddev:3085.41 (62.5%) stddev-sans-first:3078.54 04:40:01 INFO - PROCESS | 1675 | Values: 1455.1 1500.4 1671.6 1781.7 1783.1 7776.9 8356.0 8369.8 8883.1 8886.3 8539.5 8543.8 8718.1 8749.6 8764.6 2335.8 2370.8 2380.3 2384.3 2394.1 1905.9 2298.6 2364.8 2365.7 2373.5 2020.1 2337.5 2347.4 2355.5 2375.9 2062.5 2255.4 2316.8 2338.2 2346.8 2345.7 2348.0 2350.6 2354.8 2359.3 8245.6 8397.1 8408.7 8475.8 8503.3 5138.5 5231.6 5284.8 5307.5 5317.3 3425.7 3468.4 3541.2 3555.7 3644.1 1092.6 1108.3 1780.7 1845.0 1899.8 9095.9 11299.0 11488.6 11505.6 11570.2 3844.8 4339.2 4399.5 4557.5 4559.7 7695.6 9094.6 9095.4 9096.4 9119.5 5139.4 5144.0 5147.3 5150.2 5156.2 4347.8 4550.8 4745.1 4767.2 4841.5 3819.8 3871.8 3885.4 4021.8 4056.3 1265.3 1287.2 1292.3 1308.3 1311.2 796.3 860.0 900.1 937.0 964.3 4754.9 5658.4 5759.0 5832.2 6046.3 428.7 446.2 448.8 453.1 455.5 3532.3 3993.7 4114.9 4116.3 4150.1 10129.0 10576.8 10605.7 10606.5 10609.6 10388.7 10490.8 10548.9 10559.0 10564.8 6856.3 7336.8 7913.4 8149.7 8171.3 5804.5 5860.4 5972.4 5975.5 6007.6 9799.9 9911.1 9913.4 9922.2 9930.0 8092.6 10000.2 10010.8 10096.8 10127.7 6304.7 6909.2 7289.3 7475.2 7584.2 7074.2 8400.5 8401.5 8408.1 8414.2 7438.1 7530.4 7582.1 7653.7 7663.3 7387.4 7401.4 7424.6 7567.0 7585.2 6887.5 7002.3 7004.9 7026.1 7036.0 4901.8 4978.0 5063.3 5080.9 5119.8 4704.7 4980.4 5041.1 5130.5 5205.6 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | [#4] prototype.html Cycles:180 Average:4311.63 Median:4611.96 stddev:1279.69 (27.7%) stddev-sans-first:1247.11 04:40:01 INFO - PROCESS | 1675 | Values: 286.7 297.3 310.6 311.8 315.5 5075.6 5446.0 5600.9 5679.2 5706.9 5162.0 5457.9 5578.6 5592.8 5600.2 3522.8 3704.6 4277.3 4282.8 4299.4 4151.0 4177.2 4224.0 4251.1 4332.6 3430.0 3838.5 4016.8 4189.8 4204.9 3833.0 4196.7 4215.8 4230.0 4284.7 3614.6 3683.2 3684.8 3685.8 3706.7 4113.3 4139.5 4295.9 4806.9 5011.3 3909.7 4573.6 4652.8 4681.8 4850.5 5087.4 5582.5 5648.5 5700.5 5966.0 3340.8 3613.4 3984.4 3985.4 4017.2 6208.2 6231.1 6234.9 6250.7 6278.7 3853.8 4075.8 4108.2 4108.8 4111.2 3783.7 3962.7 4141.8 4152.0 4155.7 4043.2 4736.5 4823.0 4842.2 4884.9 5091.5 5245.3 5400.4 5471.6 5944.6 1242.5 1336.6 1415.9 1424.2 1426.4 947.0 957.6 970.3 971.3 986.6 5083.4 5201.2 5462.9 5479.8 5484.3 5244.5 5490.9 6032.3 6061.8 6064.5 5008.9 5018.6 5288.5 5428.9 5474.8 2663.3 2705.3 2707.8 2719.7 2731.0 4527.4 4532.7 4863.6 5013.5 5339.5 4478.9 4790.3 4898.8 5165.4 5218.5 4245.9 4479.5 4858.5 5243.6 5297.9 4202.2 4540.8 5088.4 5159.7 5186.8 4168.5 4309.5 4788.1 5058.7 5083.9 4231.4 4448.7 4694.0 4914.3 5286.5 3185.5 3190.6 3231.6 3476.8 3544.9 3955.5 4519.2 4610.1 4720.6 5062.0 4280.3 4520.4 4600.5 4638.0 4659.0 4381.1 4613.8 4687.0 4821.4 4968.9 4385.6 4497.9 4566.0 4712.6 4833.0 3878.7 4121.6 4584.6 4853.9 4946.2 4001.7 4738.3 4745.7 4925.9 4926.9 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - PROCESS | 1675 | [#5] yui.html Cycles:180 Average:24095.57 Median:3679.14 stddev:37695.89 (1024.6%) stddev-sans-first:37760.46 04:40:01 INFO - PROCESS | 1675 | Values: 630.1 704.8 742.6 762.7 786.0 12016.7 12762.4 15490.0 15617.8 15708.3 13836.4 14180.9 14218.5 14263.3 14267.0 682.5 840.1 844.8 869.7 869.9 872.5 874.0 874.1 876.1 876.6 884.7 923.9 924.2 924.3 925.4 868.9 877.6 890.4 923.7 923.8 670.6 683.8 685.3 685.6 689.1 13555.2 13721.0 13725.2 13738.9 13743.2 11703.5 11929.9 13334.9 14030.9 14777.5 11773.8 11830.2 11918.8 11988.8 12348.9 3623.1 3874.2 3881.7 3983.2 4006.4 103316.0 105306.0 106997.5 107001.0 107310.5 10621.8 11301.0 11387.4 11604.7 11859.3 20146.3 21554.0 22133.6 22844.2 22887.7 8107.6 8195.4 8280.2 8357.6 8410.5 4519.8 4602.2 4612.4 4649.6 4803.5 3560.9 3672.8 3685.5 3686.2 3686.4 634.5 646.0 657.3 659.4 671.5 525.8 614.2 666.3 689.3 710.5 9062.5 9602.7 9647.3 9697.7 9745.4 572.7 626.9 652.7 668.6 699.5 4513.9 4658.2 4768.4 4854.9 4910.7 101176.5 101934.0 120735.0 121496.0 140846.0 140304.0 141622.0 142093.6 143258.0 145075.5 94260.6 95839.5 97011.5 100337.0 111585.0 9775.6 9820.4 10099.8 10123.9 10157.5 59168.8 59973.8 64754.7 66616.3 68433.6 89014.6 95958.0 96294.0 97568.5 99005.5 12700.8 12959.2 13118.9 13188.7 13641.5 14942.3 15074.8 15086.5 15111.3 15193.3 13634.7 13686.4 13697.3 13766.4 13907.7 12410.6 13715.3 13864.9 14320.6 14437.1 10809.8 13766.4 13806.4 13842.2 14029.9 11284.2 11410.9 11491.1 11505.2 11902.6 9229.4 9948.7 10142.0 10245.5 10293.1 04:40:01 INFO - PROCESS | 1675 | -------- Summary: end -------- 04:40:01 INFO - PROCESS | 1675 | 04:40:01 INFO - TEST-INFO | 1675: exit 0 04:40:01 INFO - TEST-OK | dromaeo_css | took 1114794ms 04:40:01 INFO - TEST-START | kraken 04:40:01 INFO - operating with platform_type : mac_ 04:40:01 INFO - Initialising browser for kraken test... 04:40:01 INFO - TEST-INFO | started process 1799 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpYjN4JB/profile http://localhost:49280/getInfo.html) 04:40:04 INFO - PROCESS | 1799 | __metrics Screen width/height:1600/1200 04:40:04 INFO - PROCESS | 1799 | colorDepth:24 04:40:04 INFO - PROCESS | 1799 | Browser inner width/height: 1024/689 04:40:04 INFO - PROCESS | 1799 | __metrics 04:40:04 ERROR - PROCESS | 1799 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 04:40:05 INFO - TEST-INFO | 1799: exit 0 04:40:05 INFO - Browser initialized. 04:40:05 INFO - Running cycle 1/1 for kraken test... 04:40:05 INFO - TEST-INFO | started process 1801 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/tmpYjN4JB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:40:17 INFO - PROCESS | 1801 | RSS: Main: 254652416 04:40:17 INFO - PROCESS | 1801 | 04:40:20 INFO - PROCESS | 1801 | 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) 04:40:21 INFO - PROCESS | 1801 | RSS: Main: 267849728 04:40:21 INFO - PROCESS | 1801 | 04:40:23 INFO - PROCESS | 1801 | 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) 04:40:24 INFO - PROCESS | 1801 | RSS: Main: 276602880 04:40:24 INFO - PROCESS | 1801 | 04:40:28 INFO - PROCESS | 1801 | 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) 04:40:28 INFO - PROCESS | 1801 | RSS: Main: 279699456 04:40:28 INFO - PROCESS | 1801 | 04:40:30 INFO - PROCESS | 1801 | 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) 04:40:31 INFO - PROCESS | 1801 | RSS: Main: 280956928 04:40:31 INFO - PROCESS | 1801 | 04:40:33 INFO - PROCESS | 1801 | 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) 04:40:34 INFO - PROCESS | 1801 | RSS: Main: 281354240 04:40:34 INFO - PROCESS | 1801 | 04:40:36 INFO - PROCESS | 1801 | 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) 04:40:37 INFO - PROCESS | 1801 | RSS: Main: 283353088 04:40:37 INFO - PROCESS | 1801 | 04:40:40 INFO - PROCESS | 1801 | 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) 04:40:41 INFO - PROCESS | 1801 | RSS: Main: 284008448 04:40:41 INFO - PROCESS | 1801 | 04:40:44 INFO - PROCESS | 1801 | 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) 04:40:44 INFO - PROCESS | 1801 | RSS: Main: 283901952 04:40:44 INFO - PROCESS | 1801 | 04:40:46 INFO - PROCESS | 1801 | 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) 04:40:47 INFO - PROCESS | 1801 | RSS: Main: 283529216 04:40:47 INFO - PROCESS | 1801 | 04:40:49 INFO - PROCESS | 1801 | 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) 04:40:49 INFO - PROCESS | 1801 | RSS: Main: 283025408 04:40:49 INFO - PROCESS | 1801 | 04:40:51 INFO - PROCESS | 1801 | 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) 04:40:52 INFO - PROCESS | 1801 | RSS: Main: 283480064 04:40:52 INFO - PROCESS | 1801 | 04:40:55 INFO - PROCESS | 1801 | 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) 04:40:56 INFO - PROCESS | 1801 | RSS: Main: 283541504 04:40:56 INFO - PROCESS | 1801 | 04:40:58 INFO - PROCESS | 1801 | 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) 04:40:59 INFO - PROCESS | 1801 | RSS: Main: 283435008 04:40:59 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | 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) 04:41:01 INFO - PROCESS | 1801 | RSS: Main: 284295168 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | __start_tp_report 04:41:01 INFO - PROCESS | 1801 | _x_x_mozilla_page_load 04:41:01 INFO - PROCESS | 1801 | _x_x_mozilla_page_load_details 04:41:01 INFO - PROCESS | 1801 | |i|pagename|runs| 04:41:01 INFO - PROCESS | 1801 | |0;ai-astar;110;117;111;131;169;102;136;126;171;95 04:41:01 INFO - PROCESS | 1801 | |1;audio-beat-detection;154;111;152;152;151;163;156;118;200;95 04:41:01 INFO - PROCESS | 1801 | |2;audio-dft;208;212;216;228;207;259;274;224;237;214 04:41:01 INFO - PROCESS | 1801 | |3;audio-fft;70;80;77;142;59;60;59;63;151;76 04:41:01 INFO - PROCESS | 1801 | |4;audio-oscillator;69;70;112;69;70;91;115;71;73;117 04:41:01 INFO - PROCESS | 1801 | |5;imaging-gaussian-blur;91;88;91;89;92;87;91;89;90;88 04:41:01 INFO - PROCESS | 1801 | |6;imaging-darkroom;149;138;96;121;130;153;106;151;109;153 04:41:01 INFO - PROCESS | 1801 | |7;imaging-desaturate;131;91;90;97;129;89;91;91;91;92 04:41:01 INFO - PROCESS | 1801 | |8;json-parse-financial;54;58;54;56;54;58;54;58;57;79 04:41:01 INFO - PROCESS | 1801 | |9;json-stringify-tinderbox;68;70;66;75;73;76;75;71;70;76 04:41:01 INFO - PROCESS | 1801 | |10;stanford-crypto-aes;86;83;82;88;98;102;84;85;87;85 04:41:01 INFO - PROCESS | 1801 | |11;stanford-crypto-ccm;139;141;138;140;142;162;156;172;140;181 04:41:01 INFO - PROCESS | 1801 | |12;stanford-crypto-pbkdf2;163;172;166;175;168;169;168;164;166;166 04:41:01 INFO - PROCESS | 1801 | |13;stanford-crypto-sha256-iterative;69;65;66;67;65;67;67;68;67;68 04:41:01 INFO - PROCESS | 1801 | __end_tp_report 04:41:01 INFO - PROCESS | 1801 | __start_cc_report 04:41:01 INFO - PROCESS | 1801 | _x_x_mozilla_cycle_collect,1055 04:41:01 INFO - PROCESS | 1801 | __end_cc_report 04:41:01 INFO - PROCESS | 1801 | __startTimestamp1470656461531__endTimestamp 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | ------- Summary: start ------- 04:41:01 INFO - PROCESS | 1801 | Number of tests: 14 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#0] ai-astar Cycles:10 Average:126.80 Median:133.50 stddev:26.02 (19.5%) stddev-sans-first:26.87 04:41:01 INFO - PROCESS | 1801 | Values: 110.0 117.0 111.0 131.0 169.0 102.0 136.0 126.0 171.0 95.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:155.00 stddev:29.94 (19.3%) stddev-sans-first:31.59 04:41:01 INFO - PROCESS | 1801 | Values: 154.0 111.0 152.0 152.0 151.0 163.0 156.0 118.0 200.0 95.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#2] audio-dft Cycles:10 Average:227.90 Median:226.00 stddev:22.63 (10.0%) stddev-sans-first:22.83 04:41:01 INFO - PROCESS | 1801 | Values: 208.0 212.0 216.0 228.0 207.0 259.0 274.0 224.0 237.0 214.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#3] audio-fft Cycles:10 Average:83.70 Median:66.50 stddev:34.07 (51.2%) stddev-sans-first:35.77 04:41:01 INFO - PROCESS | 1801 | Values: 70.0 80.0 77.0 142.0 59.0 60.0 59.0 63.0 151.0 76.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#4] audio-oscillator Cycles:10 Average:85.70 Median:70.00 stddev:21.05 (30.1%) stddev-sans-first:21.44 04:41:01 INFO - PROCESS | 1801 | Values: 69.0 70.0 112.0 69.0 70.0 91.0 115.0 71.0 73.0 117.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:90.50 stddev:1.65 (1.8%) stddev-sans-first:1.67 04:41:01 INFO - PROCESS | 1801 | Values: 91.0 88.0 91.0 89.0 92.0 87.0 91.0 89.0 90.0 88.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#6] imaging-darkroom Cycles:10 Average:130.60 Median:150.00 stddev:21.54 (14.4%) stddev-sans-first:21.79 04:41:01 INFO - PROCESS | 1801 | Values: 149.0 138.0 96.0 121.0 130.0 153.0 106.0 151.0 109.0 153.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#7] imaging-desaturate Cycles:10 Average:99.20 Median:91.00 stddev:16.38 (18.0%) stddev-sans-first:12.70 04:41:01 INFO - PROCESS | 1801 | Values: 131.0 91.0 90.0 97.0 129.0 89.0 91.0 91.0 91.0 92.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.50 stddev:7.52 (13.1%) stddev-sans-first:7.83 04:41:01 INFO - PROCESS | 1801 | Values: 54.0 58.0 54.0 56.0 54.0 58.0 54.0 58.0 57.0 79.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:74.00 stddev:3.53 (4.8%) stddev-sans-first:3.43 04:41:01 INFO - PROCESS | 1801 | Values: 68.0 70.0 66.0 75.0 73.0 76.0 75.0 71.0 70.0 76.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#10] stanford-crypto-aes Cycles:10 Average:88.00 Median:85.50 stddev:6.63 (7.8%) stddev-sans-first:7.00 04:41:01 INFO - PROCESS | 1801 | Values: 86.0 83.0 82.0 88.0 98.0 102.0 84.0 85.0 87.0 85.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#11] stanford-crypto-ccm Cycles:10 Average:151.10 Median:149.00 stddev:15.72 (10.5%) stddev-sans-first:16.05 04:41:01 INFO - PROCESS | 1801 | Values: 139.0 141.0 138.0 140.0 142.0 162.0 156.0 172.0 140.0 181.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:3.62 (2.2%) stddev-sans-first:3.42 04:41:01 INFO - PROCESS | 1801 | Values: 163.0 172.0 166.0 175.0 168.0 169.0 168.0 164.0 166.0 166.0 04:41:01 INFO - PROCESS | 1801 | 04:41:01 INFO - PROCESS | 1801 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.12 04:41:01 INFO - PROCESS | 1801 | Values: 69.0 65.0 66.0 67.0 65.0 67.0 67.0 68.0 67.0 68.0 04:41:01 INFO - PROCESS | 1801 | -------- Summary: end -------- 04:41:01 INFO - PROCESS | 1801 | 04:41:02 INFO - TEST-INFO | 1801: exit 0 04:41:02 INFO - TEST-OK | kraken | took 60486ms 04:41:02 INFO - SUITE-END | took 1175s 04:41:02 INFO - Completed test suite (00:19:35) 04:41:02 INFO - javascript benchmark 04:41:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7151.42350067014, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3366.2594229269553, 3388.220709236876, 3404.3872103021463, 3415.5559777228955, 3422.4524076147823, 4457.821687132511, 5009.749512524369, 5098.949010509889, 5620.0, 5722.399148089448, 5459.945400545993, 5478.260434841295, 5724.942750572493, 5731.254936858213, 5740.56945729071, 4518.344839998198, 5150.922736158961, 5238.607104467161, 5264.763085661135, 5301.867453313659, 5294.814681486148, 5343.893122137555, 5360.812371566996, 5397.62216644835, 5414.296141501619, 5163.741812909377, 5191.506806853343, 5224.921626175629, 5257.605679574009, 5295.0, 5252.9737351313, 5253.553447956928, 5272.868178295535, 5276.472352764731, 5303.840884773463, 5188.247704082924, 5192.0, 5252.973735131338, 5270.736463176864, 5274.472552744734, 4496.820127194908, 5629.549636029149, 5658.207850900877, 5688.658680479184, 5695.686737229451, 6212.316645169028, 6214.937850621526, 6265.655388953652, 6284.088807122987, 6294.307626161119, 6255.155554000243, 6273.811785646438, 6294.402031806971, 6297.2128483939505, 6306.558540902139, 5711.685857277848, 5800.50695690871, 5833.533317334645, 5847.0, 5867.2959244890035, 6284.497240220771, 6288.056791481315, 6288.748450061947, 6305.432511074026, 6319.494440444753, 6187.566870319124, 6188.907166392508, 6207.410296021871, 6212.161358216673, 6229.688515574203, 6109.419605137505, 6120.965252118766, 6164.938350616437, 6197.349278325711, 6204.875902481925, 6221.471174950089, 6225.470834978987, 6240.469560087444, 6244.469220116341, 6253.155823963798, 4662.790174442158, 4988.925166122511, 6251.624902505773, 6258.812235632939, 6262.9666105093065, 4878.365812444359, 4949.084419382426, 4969.627277954168, 4972.67677600962, 4978.103941290602, 4467.687261891701, 4473.955260447354, 4481.574250446268, 4504.774761261924, 4516.345129956138, 5680.0627896397455, 5767.8558036049435, 5768.2501274834, 5772.220750198753, 5778.971105144531, 5336.039512887717, 6014.36849130835, 6176.69116544171, 6181.690915454299, 6255.218097737783, 4587.977060114678, 5771.711414429262, 5794.681292528867, 5847.38602446737, 5864.589478736533, 5451.890962180734, 5463.125899856004, 5490.423505531941, 5512.724363781795, 5529.253550770675, 6179.505639548735, 6229.719662615284, 6350.428461438492, 6362.141110949962, 6385.936140638627, 6219.40915613016, 6247.187865577446, 6266.655333956676, 6275.466585340298, 6278.340774218641, 6236.438720515175, 6330.8100756977365, 6335.968320158554, 6340.841478963062, 6356.555041147075, 6053.334133245427, 6098.613770999223, 6133.662648554372, 6168.629882207082, 6186.0, 5320.920186197288, 5909.6158749681135, 6209.5032397409, 6216.409441103269, 6251.99968005117, 6170.136180934583, 6175.44421002112, 6175.9073613894925, 6178.9382106180165, 6186.4741496973265, 5610.13042978339, 5937.406259374028, 6085.786997455068, 6158.168647232566, 6180.7527698891545, 5888.4700376966275, 5968.492678122235, 6006.189164462741, 6077.513798896166, 6095.085737139465, 6164.969175154096, 6178.845528861814, 6184.659843708459, 6186.752529898934, 6214.782482613087, 5846.298444186555, 5959.553033522417, 6002.159697642246, 6031.728572214349, 6049.909251361321], "value": 5667.816456586694, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.7748864312166, 539.3689383421397, 540.087252543202, 549.6866785932018, 552.4806681719186, 31451.68548314516, 40101.59898401012, 40119.79940100303, 40120.99697507556, 40175.59824401755, 32766.508502372482, 35447.0, 40368.59631403685, 40840.57058002971, 41096.0, 9348.626054957793, 9411.341206115574, 9498.952505237465, 9556.61773529058, 9614.086661767122, 8114.756557303261, 8143.674253029872, 9543.713688589318, 9543.761405964871, 9579.377340472882, 9566.0, 9576.138147566717, 9587.376820506679, 9603.791128040555, 9618.182454491376, 8401.327893768514, 8976.8653470198, 9550.61797528098, 9594.42433453995, 9608.327417080807, 9413.435193888388, 9493.335466517347, 9519.714838496784, 9520.619175233052, 9522.333436659437, 38737.61262387368, 38907.805460972515, 39038.80480597607, 39132.80433597814, 39180.412293815614, 2880.6399200099986, 3076.0, 3374.295372097985, 3379.8986030418882, 3517.964820351815, 29483.557746633818, 29718.70281297181, 29730.662120204644, 29743.70256297431, 30332.241693957607, 3087.0, 3087.536869469575, 3115.8597863096215, 3137.090243829287, 3234.87060517579, 405240.0, 412847.0, 416151.0, 416391.0, 419221.0, 32656.673433265838, 32708.67291327104, 32813.343733125206, 32818.0, 32942.67057329444, 33693.83153084219, 33729.0, 33797.83101084479, 35094.649053509645, 35265.47101793475, 15904.76142857858, 16012.199390030451, 16012.799040071808, 16057.919710401608, 16063.277152528164, 12264.080193985486, 12365.319907404999, 12411.441485133191, 12412.75174496505, 12444.875551244371, 18568.25726970933, 18743.906280468782, 18769.0, 18868.716969245474, 18937.715934260996, 6433.420992110732, 7772.261635144652, 7810.414218933603, 7882.605869706606, 7918.406119541058, 887.8179973105498, 970.2819913264275, 983.341161421849, 1001.9699409017741, 1014.4674046125843, 26398.736012640013, 27195.456090878466, 27372.45255094887, 29710.55434168446, 30460.847695761822, 1013.6300250408548, 1061.2518174686827, 1079.0935614084208, 1083.2417307884512, 1095.2771171027243, 13181.406836692371, 14903.105813650998, 15110.773338399933, 15165.924170379078, 15241.390344386322, 523768.905777351, 613475.0, 617075.0, 622657.0, 622769.0, 54302.0, 54605.45394546004, 54697.45302547003, 54882.0, 55006.72496637491, 1336.6457888659513, 1370.0751992405087, 1395.0653062448184, 1400.7758758598575, 1403.0669604712753, 22905.19831805879, 28169.295767605974, 28426.715732842407, 28672.0, 28950.565741514314, 39212.01969950774, 48197.75901120472, 48833.0, 49233.507664922894, 49557.0, 575226.0, 575970.0, 577098.0, 580507.0, 581077.0, 22448.887755561773, 25780.09769658053, 26013.21960341193, 26182.34544136412, 26270.343241419116, 43339.0, 45856.31215531703, 47713.0, 47965.5203447961, 48291.0, 32821.05881123802, 38604.6139538601, 39189.216215674955, 40025.399619005155, 40386.0, 39283.41074883822, 39532.40701389539, 39660.80169599134, 40741.59258407496, 40907.0, 32376.838115810213, 37339.43990840194, 37791.244175116895, 37860.62139378571, 37996.2400751989, 28101.578476322462, 33398.332033359686, 34287.82856085704, 34454.48318275278, 34583.308333832676, 25314.873425632755, 25500.617490738026, 25927.611085834105, 26060.34849128787, 26370.736292637597], "value": 18774.53175580217, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4401104194642, 359.60802725029714, 368.3939918833519, 385.76468354303853, 394.91509325495014, 20229.898850505746, 20258.797412025877, 21382.99999999998, 21597.244096456627, 21654.675179872276, 19070.427887163372, 20466.38600841977, 21048.89475552624, 21166.788332116674, 21235.239418875564, 4970.776315065813, 5604.523615492668, 5789.855253618673, 6014.729337179838, 6027.397260273981, 5965.164876917235, 6002.819915402545, 6005.579609427342, 6018.488428483584, 6048.788292409767, 5779.104238842986, 5811.360750317462, 5853.975554278006, 5916.437938395846, 5988.071848863411, 5995.4304341087745, 6022.96988515059, 6026.674131691021, 6029.69851507425, 6056.152138700585, 5131.923021154686, 5408.513233808937, 5411.161270003156, 5490.505854473116, 5522.641028333145, 13040.413181406859, 13098.214107153506, 13144.60566183016, 13189.736205275936, 13418.396172172275, 2075.9065842037144, 2154.310620601408, 2168.1435832846096, 2479.454520005596, 2730.6586676665415, 8007.95996020022, 9886.752831179207, 9955.054269844426, 10338.431386273753, 10393.012663796928, 1749.3177660712333, 1811.4384540792264, 1840.3006857394105, 1851.583393736412, 1897.7627796525435, 110121.0, 115364.42317788357, 128767.71232287651, 129709.0, 131600.3419982894, 9043.59303831329, 11536.480858361394, 11557.0, 11565.884341156649, 11757.470913808898, 12795.61613151607, 13554.322283885964, 14057.086289391156, 14394.928025360015, 14417.711645767236, 8247.793805154919, 8522.190391912758, 8556.700515481929, 8628.396012279205, 8641.567921603895, 8504.44721093127, 8513.276371508491, 8514.616842242114, 8584.656613735506, 8707.042225355206, 4446.2663660495655, 4451.465824101064, 4487.461504619401, 4565.292379681155, 4579.931301030487, 1644.0300222868566, 1881.5484283771796, 1892.3093071028975, 1932.8743631664179, 1943.7181608666665, 757.4811254290828, 822.9094799572042, 870.5995242188537, 919.5678031325266, 964.4695417520336, 20011.699824502353, 20891.059902304434, 21138.682919756215, 21361.415936246955, 21522.246721364678, 907.8728977943093, 911.5077857956762, 963.3738070254251, 967.937084089546, 1021.1881554164457, 9284.582193801296, 10045.69862904114, 11158.665240042812, 11179.83230251547, 11185.776284474265, 543858.0, 562620.1868990628, 570817.0, 587092.0, 591058.0, 96880.0, 106742.46628766807, 110288.4485577567, 130682.0, 138169.0, 895.1943251073956, 975.0785507695301, 981.1807141037314, 1021.3769600543662, 1023.2632504596678, 15115.470958516398, 17624.942503449834, 19201.32795352156, 19268.903655482194, 19352.8064719351, 35471.29057418786, 39568.0, 47776.04447910953, 53746.65633359041, 55166.44833551613, 53765.0, 81511.0, 83255.583722081, 84033.0, 84304.73542896984, 6414.10202571631, 6640.402363787282, 6824.317568243136, 7612.048493938258, 8100.918990810016, 10789.949909517167, 11083.0, 12909.0, 12992.415341309475, 13798.586042418743, 11493.252938558968, 11540.596079137189, 11923.165378423773, 12056.397180141134, 12089.032877369966, 10658.467076646291, 11340.6030788922, 11655.53377864876, 11740.41297935117, 11955.103367247317, 7076.893846592408, 11264.493097810782, 11834.704132396759, 11920.225185362924, 11949.701257468632, 8222.876656850272, 8447.408681392244, 8519.105493923296, 8551.828963420821, 8576.528290943808, 5483.369412517612, 8706.347023973101, 8965.50689712072, 11604.187706860777, 11728.712900984567], "value": 9210.957696920093, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1455.0614853419543, 1500.4448354108981, 1671.5988162840922, 1781.7238328059154, 1783.1440908363984, 7776.9222307777045, 8356.0, 8369.83260334793, 8883.067277935812, 8886.289096872251, 8539.530325832093, 8543.78640533987, 8718.084601116887, 8749.562521873913, 8764.605592748325, 2335.789778919897, 2370.8221883358733, 2380.2621187431864, 2384.332386931662, 2394.1261439574605, 1905.9142338594727, 2298.5632729781373, 2364.7517010713887, 2365.7042869641296, 2373.52529494101, 2020.070767446976, 2337.4506990857135, 2347.448349637834, 2355.5171189906027, 2375.893084811179, 2062.484378905274, 2255.379770563092, 2316.8262380321544, 2338.169949667869, 2346.8474549154253, 2345.6598793174894, 2348.03730470508, 2350.5886469867874, 2354.835161538693, 2359.3275916363928, 8245.628946697412, 8397.076321604618, 8408.747737567883, 8475.813386125947, 8503.277221436185, 5138.537531622172, 5231.581473482112, 5284.788608455658, 5307.548858347045, 5317.2821669074565, 3425.7088147507493, 3468.358353704573, 3541.1855273287288, 3555.6532688425773, 3644.0889777555612, 1092.579356947573, 1108.3349990006013, 1780.652772709322, 1844.97232541512, 1899.8005209452947, 9095.909040909572, 11299.039581635489, 11488.597899073493, 11505.5973040944, 11570.247933884355, 3844.7693138411787, 4339.153864996359, 4399.472063352354, 4557.453105627346, 4559.6808223424705, 7695.6152192390155, 9094.636214551476, 9095.36332456735, 9096.408733432438, 9119.498427586546, 5139.434662187156, 5144.048351055067, 5147.330846989942, 5150.201718733602, 5156.226566015052, 4347.847825326162, 4550.795214215368, 4745.074710431501, 4767.189577771718, 4841.491643377465, 3819.8472061117245, 3871.7870517121264, 3885.4171874218528, 4021.7989100544855, 4056.2698714231133, 1265.3167289663663, 1287.2083668543778, 1292.3473645808995, 1308.3196737696535, 1311.1608570514877, 796.2596619614872, 859.9699010534601, 900.1133883125117, 937.0067728207985, 964.2671569607149, 4754.857354279377, 5658.405867383865, 5759.0, 5832.24180856486, 6046.3046749624355, 428.67420760222456, 446.2458445227555, 448.7957979119493, 453.09833431471793, 455.5285279735458, 3532.3111993161087, 3993.72043956926, 4114.876553703393, 4116.341385378325, 4150.149219410074, 10129.0, 10576.788464230673, 10605.681829545127, 10606.469676516297, 10609.575616975235, 10388.688339349832, 10490.790184196274, 10548.947255263674, 10559.0, 10564.841527377095, 6856.348646878539, 7336.816579585553, 7913.406494512935, 8149.674013039412, 8171.346292296602, 5804.477597016289, 5860.355360910211, 5972.402759723993, 5975.492083172979, 6007.609505382136, 9799.85300220483, 9911.058449447291, 9913.355631883904, 9922.206223501958, 9930.0, 8092.595370231583, 10000.24998125129, 10010.849837252592, 10096.798064038825, 10127.7468063299, 6304.65324407162, 6909.205441374306, 7289.307515785992, 7475.177730449537, 7584.165741768511, 7074.186468556182, 8400.537970411686, 8401.495910245405, 8408.117147699404, 8414.200650938152, 7438.107427108782, 7530.397568194422, 7582.090149182133, 7653.693852245848, 7663.27198916102, 7387.372073373608, 7401.370883474965, 7424.628768561658, 7566.9784579081115, 7585.165631780389, 6887.483438742014, 7002.2647622000995, 7004.929950700632, 7026.1217347831525, 7035.964820175866, 4901.754912254444, 4978.029284289529, 5063.265826455217, 5080.872978175576, 5119.846404607719, 4704.741239231875, 4980.352554167935, 5041.117804384145, 5130.538251557377, 5205.568468671146], "value": 4460.939453324574, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.65744435399694, 297.3072740514601, 310.6055309756608, 311.82070309572003, 315.4920577869631, 5075.593952483801, 5445.9727701361535, 5600.859978500534, 5679.182661548301, 5706.942930570693, 5162.045021670993, 5457.918131228025, 5578.581606379517, 5592.7762889484475, 5600.235925683407, 3522.771019883712, 3704.6292871637397, 4277.315629499289, 4282.828686852522, 4299.355096735483, 4150.97924510377, 4177.17426446816, 4224.049588842517, 4251.128518653669, 4332.631726303252, 3429.9828500857584, 3838.539375274971, 4016.7748836604824, 4189.779416909043, 4204.852830150945, 3833.0225792422752, 4196.727212731178, 4215.768132752697, 4229.963658903573, 4284.67864910133, 3614.6083757753454, 3683.226522430293, 3684.778913265186, 3685.7836913818373, 3706.721995850322, 4113.321301985169, 4139.503259608866, 4295.871123866289, 4806.903861922777, 5011.291644183279, 3909.706771992112, 4573.588377046049, 4652.8138874444985, 4681.765911704401, 4850.53919877611, 5087.440381558025, 5582.525485333752, 5648.519875810561, 5700.486956173964, 5965.970170149121, 3340.816255105968, 3613.3676606594004, 3984.3824207247635, 3985.362342025262, 4017.196560687874, 6208.192934918477, 6231.130660801741, 6234.875302493925, 6250.718717657671, 6278.654673992928, 3853.7687738735767, 4075.775832329191, 4108.198901214235, 4108.801791041778, 4111.218868414991, 3783.6783873371073, 3962.663173630216, 4141.7722025288895, 4151.958480415217, 4155.688323375759, 4043.1509383029306, 4736.455307639666, 4822.95177048232, 4842.225243960949, 4884.926726099111, 5091.541761241432, 5245.318108645928, 5400.351957765015, 5471.6169868108855, 5944.613600115978, 1242.4655550395255, 1336.565616174747, 1415.9221242831743, 1424.223798030076, 1426.3866537388815, 946.9810603787886, 957.5738796235747, 970.3110791338088, 971.3152227679469, 986.6250824686573, 5083.415407228142, 5201.219817027476, 5462.863428414322, 5479.835604931858, 5484.2596249505805, 5244.5279924806955, 5490.858565159591, 6032.276126864805, 6061.7575296987625, 6064.545159112996, 5008.924866127011, 5018.573421259161, 5288.497592728685, 5428.945710542923, 5474.835754927359, 2663.2942270298386, 2705.2830999785074, 2707.837529748221, 2719.6600424946882, 2730.9726902731118, 4527.411436513298, 4532.682712210114, 4863.61387004709, 5013.473585273567, 5339.546138578186, 4478.888027799266, 4790.329353890458, 4898.828541001048, 5165.358422312261, 5218.547282777089, 4245.936310955338, 4479.529649386767, 4858.46556878743, 5243.632945693765, 5297.867553311198, 4202.243596152722, 4540.795664195185, 5088.430342676925, 5159.742012899265, 5186.766595503287, 4168.458100446923, 4309.482862056573, 4788.079271644364, 5058.671186372874, 5083.92374114396, 4231.3821682462285, 4448.687637146984, 4694.0, 4914.287428322802, 5286.524212820865, 3185.5221716742676, 3190.633077196152, 3231.579894613685, 3476.774009689362, 3544.9291014179057, 3955.4857868476915, 4519.209138400701, 4610.124076425468, 4720.598749106364, 5062.0, 4280.336547835091, 4520.3500722235485, 4600.470945841271, 4638.005657567279, 4659.038124397506, 4381.145676593033, 4613.792379342871, 4686.984596623484, 4821.408935051495, 4968.875778105432, 4385.605295523418, 4497.910041799211, 4566.018306064212, 4712.59942904857, 4832.95167048325, 3878.7090968178063, 4121.649659778953, 4584.610308123847, 4853.927191092207, 4946.15915294408, 4001.7198796083994, 4738.336632871332, 4745.6746194365205, 4925.9014819704125, 4926.852194434173], "value": 3921.618270444822, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [630.0612087988895, 704.8167476456122, 742.624974387934, 762.6644276518333, 785.9743035338884, 12016.699582510431, 12762.361881905914, 15490.0, 15617.84382156178, 15708.293126809293, 13836.446542138328, 14180.929095354535, 14218.502352417667, 14263.286835658228, 14267.0, 682.4676752133344, 840.0885039731899, 844.7972486603232, 869.7303835810919, 869.8782170496136, 872.4808738800403, 873.9905409252292, 874.0996773323487, 876.0844917061686, 876.5617191404298, 884.7168905950099, 923.9214666753334, 924.2282693950559, 924.3113880159257, 925.4123631493983, 868.8783570300163, 877.6445539556458, 890.412327863607, 923.727500387384, 923.8244733500613, 670.6244503078292, 683.8016975077221, 685.2804555217002, 685.5954986557955, 689.0835189198355, 13555.186688798703, 13721.039527232997, 13725.176489410667, 13738.931305343509, 13743.244121573309, 11703.53185872564, 11929.940350298193, 13334.866651333556, 14030.94767892402, 14777.482788102365, 11773.823392649118, 11830.231034982784, 11918.821217681741, 11988.760224795455, 12348.938255308756, 3623.1304486923214, 3874.2057878134915, 3881.6894648428056, 3983.223271462066, 4006.3790112532606, 103316.0, 105306.0, 106997.46501267522, 107001.0, 107310.46344768227, 10621.787564248672, 11301.0, 11387.430628468543, 11604.651860444032, 11859.300473002273, 20146.294879679142, 21554.0, 22133.557328853654, 22844.200452984067, 22887.656685149737, 8107.635156417975, 8195.42632015765, 8280.213379728915, 8357.58212089393, 8410.453320534269, 4519.796609152596, 4602.217623004098, 4612.423447069116, 4649.581537661559, 4803.519648035239, 3560.946585801215, 3672.779633222015, 3685.5024571683016, 3686.2258925625383, 3686.3733165361955, 634.508256101525, 645.9677016149174, 657.2769953051701, 659.4394764450179, 671.4963777167125, 525.7975679363396, 614.2199406753398, 666.3303380102966, 689.3224646510821, 710.4884483172108, 9062.549992001248, 9602.66390676323, 9647.276454265959, 9697.709068727949, 9745.415275083518, 572.7165053298561, 626.8683576448997, 652.6964961293022, 668.6188872342815, 699.478888228263, 4513.932291015637, 4658.231391820312, 4768.403949506312, 4854.897611518261, 4910.680805747615, 101176.49411753041, 101934.0, 120735.0, 121496.0, 140846.0, 140304.0, 141622.0, 142093.5790642101, 143258.0, 145075.46661612173, 94260.5860912087, 95839.52080239553, 97011.54482682624, 100337.0, 111585.0, 9775.608975640895, 9820.4107753535, 10099.798004040025, 10123.898761012295, 10157.542910568895, 59168.81662366815, 59973.80052399015, 64754.67622661857, 66616.33383666101, 68433.63132737218, 89014.55492722495, 95958.0, 96294.0, 97568.51215743876, 99005.50497247468, 12700.806699675564, 12959.222446653232, 13118.934405327913, 13188.670283242996, 13641.522546710818, 14942.327595258457, 15074.849251507345, 15086.471973480875, 15111.319990600668, 15193.316300766714, 13634.727305453636, 13686.384112715152, 13697.315134243447, 13766.380512877146, 13907.652308692364, 12410.5656302029, 13715.314234288446, 13864.86135138676, 14320.57038288853, 14437.06159099655, 10809.82080982106, 13766.380512876744, 13806.447742090204, 13842.238676872466, 14029.929850350683, 11284.21010529255, 11410.94294528522, 11491.138164637518, 11505.194636375709, 11902.583409580624, 9229.446233226028, 9948.651797187063, 10142.0, 10245.538950747085, 10293.125084367912], "value": 7800.58837909807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 111.0, 131.0, 169.0, 102.0, 136.0, 126.0, 171.0, 95.0], "value": 126.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 111.0, 152.0, 152.0, 151.0, 163.0, 156.0, 118.0, 200.0, 95.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 212.0, 216.0, 228.0, 207.0, 259.0, 274.0, 224.0, 237.0, 214.0], "value": 227.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 80.0, 77.0, 142.0, 59.0, 60.0, 59.0, 63.0, 151.0, 76.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 112.0, 69.0, 70.0, 91.0, 115.0, 71.0, 73.0, 117.0], "value": 85.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 92.0, 87.0, 91.0, 89.0, 90.0, 88.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 138.0, 96.0, 121.0, 130.0, 153.0, 106.0, 151.0, 109.0, 153.0], "value": 130.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 91.0, 90.0, 97.0, 129.0, 89.0, 91.0, 91.0, 91.0, 92.0], "value": 99.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 54.0, 56.0, 54.0, 58.0, 54.0, 58.0, 57.0, 79.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 66.0, 75.0, 73.0, 76.0, 75.0, 71.0, 70.0, 76.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 82.0, 88.0, 98.0, 102.0, 84.0, 85.0, 87.0, 85.0], "value": 88.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 138.0, 140.0, 142.0, 162.0, 156.0, 172.0, 140.0, 181.0], "value": 151.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 172.0, 166.0, 175.0, 168.0, 169.0, 168.0, 164.0, 166.0, 166.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 67.0, 65.0, 67.0, 67.0, 68.0, 67.0, 68.0], "value": 66.9, "unit": "score"}]}]} 04:41:02 INFO - Return code: 0 04:41:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:41:02 ERROR - # TBPL SUCCESS # 04:41:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:41:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:41:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:41:02 INFO - 2016-08-08 04:41:02.851 screenresolution[1812:10624] starting screenresolution argv=screenresolution get 04:41:02 INFO - 2016-08-08 04:41:02.854 screenresolution[1812:10624] Display 0: 1600x1200x32@60 04:41:02 INFO - 2016-08-08 04:41:02.860 screenresolution[1813:10627] starting screenresolution argv=screenresolution list 04:41:02 INFO - Available Modes on Display 0 04:41:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:41:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:41:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:41:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:41:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:41:03 INFO - Intel Iris: 04:41:03 INFO - Chipset Model: Intel Iris 04:41:03 INFO - Type: GPU 04:41:03 INFO - Bus: Built-In 04:41:03 INFO - VRAM (Dynamic, Max): 1536 MB 04:41:03 INFO - Vendor: Intel (0x8086) 04:41:03 INFO - Device ID: 0x0a2e 04:41:03 INFO - Revision ID: 0x0009 04:41:03 INFO - Displays: 04:41:03 INFO - Display: 04:41:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:41:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:41:03 INFO - Display Serial Number: 1600x1200 60 04:41:03 INFO - Main Display: Yes 04:41:03 INFO - Mirror: Off 04:41:03 INFO - Online: Yes 04:41:03 INFO - Rotation: Supported 04:41:03 INFO - Return code: 0 04:41:03 INFO - Running post-action listener: _resource_record_post_action 04:41:03 INFO - [mozharness: 2016-08-08 11:41:03.096077Z] Finished run-tests step (success) 04:41:03 INFO - Running post-run listener: _resource_record_post_run 04:41:03 INFO - Total resource usage - Wall time: 1211s; CPU: 55.0%; Read bytes: 36897792; Write bytes: 713247744; Read time: 392; Write time: 1974 04:41:03 INFO - TinderboxPrint: CPU usage
54.5% 04:41:03 INFO - TinderboxPrint: I/O read bytes / time
36,897,792 / 392 04:41:03 INFO - TinderboxPrint: I/O write bytes / time
713,247,744 / 1,974 04:41:03 INFO - TinderboxPrint: CPU idle
2,202.5 (45.5%) 04:41:03 INFO - TinderboxPrint: CPU system
984.3 (20.3%) 04:41:03 INFO - TinderboxPrint: CPU user
1,658.8 (34.2%) 04:41:03 INFO - TinderboxPrint: Swap in / out
444,096,512 / 0 04:41:03 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 383816192; Write bytes: 379627008; Read time: 28763; Write time: 692 04:41:03 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 35935232; Write bytes: 303097344; Read time: 377; Write time: 1225 04:41:03 INFO - Running post-run listener: _upload_blobber_files 04:41:03 INFO - Blob upload gear active. 04:41:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:41:03 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 04:41:03 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'] 04:41:03 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 04:41:04 INFO - (blobuploader) - INFO - Open directory for files ... 04:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:04 INFO - (blobuploader) - INFO - Done attempting. 04:41:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:41:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:41:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:06 INFO - (blobuploader) - INFO - Done attempting. 04:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:41:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:41:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:41:09 INFO - (blobuploader) - INFO - Done attempting. 04:41:09 INFO - (blobuploader) - INFO - Iteration through files over. 04:41:09 INFO - Return code: 0 04:41:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:41:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:41:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f365ce99fb13acad28f0c420d38d066a2064dc580c36d18a3140d8240f936485e69c6a6926a415bda0ef521f3738c956dfd870db2ba91904f984f0441d93188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ddec8201bcab4db4f01d170d9f482950191d7f97b4fe31597e593d951bcca70983b9f5a31df0e9ed06e5b33244067775d44f323b5276282204e4ed83afecf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c88bd52e3e19cbec6ea1912c4d24eab4cef03fcfc0874564e5ae353e002ba78c8cee0cd2637ab357026729e0858921cef749985e466d8047d29f2902c5776f80"} 04:41:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:41:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:41:09 INFO - Contents: 04:41:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f365ce99fb13acad28f0c420d38d066a2064dc580c36d18a3140d8240f936485e69c6a6926a415bda0ef521f3738c956dfd870db2ba91904f984f0441d93188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ddec8201bcab4db4f01d170d9f482950191d7f97b4fe31597e593d951bcca70983b9f5a31df0e9ed06e5b33244067775d44f323b5276282204e4ed83afecf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c88bd52e3e19cbec6ea1912c4d24eab4cef03fcfc0874564e5ae353e002ba78c8cee0cd2637ab357026729e0858921cef749985e466d8047d29f2902c5776f80"} 04:41:09 INFO - Running post-run listener: copy_logs_to_upload_dir 04:41:09 INFO - Copying logs to upload dir... 04:41:09 INFO - mkdir: /builds/slave/test/build/upload/logs 04:41:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.261492 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-08-08 04:41:09.357418) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 04:41:09.361280) ========= 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.fXXpEJAFsl/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.arG9yPVGUw/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f365ce99fb13acad28f0c420d38d066a2064dc580c36d18a3140d8240f936485e69c6a6926a415bda0ef521f3738c956dfd870db2ba91904f984f0441d93188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ddec8201bcab4db4f01d170d9f482950191d7f97b4fe31597e593d951bcca70983b9f5a31df0e9ed06e5b33244067775d44f323b5276282204e4ed83afecf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c88bd52e3e19cbec6ea1912c4d24eab4cef03fcfc0874564e5ae353e002ba78c8cee0cd2637ab357026729e0858921cef749985e466d8047d29f2902c5776f80"} build_url:https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/fc98D7qMTQqc1zlksVxdQA/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f365ce99fb13acad28f0c420d38d066a2064dc580c36d18a3140d8240f936485e69c6a6926a415bda0ef521f3738c956dfd870db2ba91904f984f0441d93188", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41ddec8201bcab4db4f01d170d9f482950191d7f97b4fe31597e593d951bcca70983b9f5a31df0e9ed06e5b33244067775d44f323b5276282204e4ed83afecf5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c88bd52e3e19cbec6ea1912c4d24eab4cef03fcfc0874564e5ae353e002ba78c8cee0cd2637ab357026729e0858921cef749985e466d8047d29f2902c5776f80"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-08 04:41:09.429651) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:41:09.429993) ========= 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.fXXpEJAFsl/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.arG9yPVGUw/Listeners TMPDIR=/var/folders/hz/6vdv9x_s7jxbq2qw6vthh2l000000w/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.005157 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-08 04:41:09.541254) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 04:41:09.541594) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-08 04:41:09.541998) ========= ========= Total master_lag: 0.29 =========