builder: autoland_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0317 starttime: 1467494764.79 results: success (0) buildid: 20160702122623 builduid: 07bed1f383144492b3cdac173a7b626d revision: d4379d1513fd8d0702fcaa458d26e00c599eebef ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:04.791866) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:04.792292) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:04.792559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:05.018259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:05.018581) ========= 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.BXhW7JlwiX/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.mABe2r23KS/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-02 14:26:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 170M=0s 2016-07-02 14:26:05 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197036 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:05.292644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:05.292952) ========= 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.BXhW7JlwiX/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.mABe2r23KS/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.027762 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:05.365462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 14:26:05.365865) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d4379d1513fd8d0702fcaa458d26e00c599eebef --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d4379d1513fd8d0702fcaa458d26e00c599eebef --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BXhW7JlwiX/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.mABe2r23KS/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-02 14:26:05,460 truncating revision to first 12 chars 2016-07-02 14:26:05,460 Setting DEBUG logging. 2016-07-02 14:26:05,460 attempt 1/10 2016-07-02 14:26:05,460 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d4379d1513fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 14:26:06,229 unpacking tar archive at: autoland-d4379d1513fd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.058524 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-02 14:26:06.466181) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:06.466479) ========= script_repo_revision: d4379d1513fd8d0702fcaa458d26e00c599eebef ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:06.466863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:06.467142) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 14:26:06.521830) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-02 14:26:06.522148) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BXhW7JlwiX/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.mABe2r23KS/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:26:06 INFO - MultiFileLogger online at 20160702 14:26:06 in /builds/slave/test 14:26:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 14:26:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:26:06 INFO - {'append_to_log': False, 14:26:06 INFO - 'base_work_dir': '/builds/slave/test', 14:26:06 INFO - 'blob_upload_branch': 'Autoland', 14:26:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:26:06 INFO - 'branch': 'Autoland', 14:26:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:26:06 INFO - 'config_files': ('talos/mac_config.py',), 14:26:06 INFO - 'default_actions': ('clobber', 14:26:06 INFO - 'read-buildbot-config', 14:26:06 INFO - 'download-and-extract', 14:26:06 INFO - 'populate-webroot', 14:26:06 INFO - 'create-virtualenv', 14:26:06 INFO - 'install', 14:26:06 INFO - 'run-tests'), 14:26:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:26:06 INFO - 'download_minidump_stackwalk': True, 14:26:06 INFO - 'download_symbols': 'ondemand', 14:26:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:26:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:26:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:26:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:26:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:26:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:26:06 INFO - 'installer_path': 'installer.exe', 14:26:06 INFO - 'log_level': 'info', 14:26:06 INFO - 'log_name': 'talos', 14:26:06 INFO - 'log_to_console': True, 14:26:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:26:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:26:06 INFO - 'opt_config_files': (), 14:26:06 INFO - 'pip_index': False, 14:26:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:06 INFO - 'cmd': ('bash', 14:26:06 INFO - '-c', 14:26:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:06 INFO - 'enabled': True, 14:26:06 INFO - 'halt_on_failure': False, 14:26:06 INFO - 'name': 'check_screen_resolution'},), 14:26:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:26:06 INFO - 'cmd': ('bash', 14:26:06 INFO - '-c', 14:26:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:26:06 INFO - 'enabled': True, 14:26:06 INFO - 'halt_on_failure': False, 14:26:06 INFO - 'name': 'check_screen_resolution'},), 14:26:06 INFO - 'run_cmd_checks_enabled': True, 14:26:06 INFO - 'sps_profile': False, 14:26:06 INFO - 'sps_profile_interval': 0, 14:26:06 INFO - 'suite': 'dromaeojs', 14:26:06 INFO - 'system_bits': '32', 14:26:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:26:06 INFO - 'title': 't-yosemite-r7-0317', 14:26:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:26:06 INFO - 'use_talos_json': True, 14:26:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:26:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:26:06 INFO - 'work_dir': 'build'} 14:26:06 INFO - ##### 14:26:06 INFO - ##### Running clobber step. 14:26:06 INFO - ##### 14:26:06 INFO - Running pre-action listener: _resource_record_pre_action 14:26:06 INFO - Running main action method: clobber 14:26:06 INFO - rmtree: /builds/slave/test/build 14:26:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:26:08 INFO - Running post-action listener: _resource_record_post_action 14:26:08 INFO - ##### 14:26:08 INFO - ##### Finished clobber step (success) 14:26:08 INFO - ##### 14:26:08 INFO - ##### 14:26:08 INFO - ##### Running read-buildbot-config step. 14:26:08 INFO - ##### 14:26:08 INFO - Running pre-action listener: _resource_record_pre_action 14:26:08 INFO - Running main action method: read_buildbot_config 14:26:08 INFO - Using buildbot properties: 14:26:08 INFO - { 14:26:08 INFO - "project": "", 14:26:08 INFO - "product": "firefox", 14:26:08 INFO - "script_repo_revision": "production", 14:26:08 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs", 14:26:08 INFO - "repository": "", 14:26:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs", 14:26:08 INFO - "buildid": "20160702122623", 14:26:08 INFO - "pgo_build": "False", 14:26:08 INFO - "basedir": "/builds/slave/test", 14:26:08 INFO - "buildnumber": 19, 14:26:08 INFO - "slavename": "t-yosemite-r7-0317", 14:26:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 14:26:08 INFO - "platform": "yosemite_r7", 14:26:08 INFO - "scheduler": "tests-autoland-macosx64-talos", 14:26:08 INFO - "branch": "autoland", 14:26:08 INFO - "repo_path": "integration/autoland", 14:26:08 INFO - "revision": "d4379d1513fd8d0702fcaa458d26e00c599eebef", 14:26:08 INFO - "stage_platform": "macosx64", 14:26:08 INFO - "builduid": "07bed1f383144492b3cdac173a7b626d", 14:26:08 INFO - "slavebuilddir": "test" 14:26:08 INFO - } 14:26:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 14:26:08 INFO - Running post-action listener: _resource_record_post_action 14:26:08 INFO - ##### 14:26:08 INFO - ##### Finished read-buildbot-config step (success) 14:26:08 INFO - ##### 14:26:08 INFO - ##### 14:26:08 INFO - ##### Running download-and-extract step. 14:26:08 INFO - ##### 14:26:08 INFO - Running pre-action listener: _resource_record_pre_action 14:26:08 INFO - Running main action method: download_and_extract 14:26:08 INFO - mkdir: /builds/slave/test/build/tests 14:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:26:08 INFO - https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 14:26:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:26:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 14:26:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:26:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 14:26:39 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 14:26:39 INFO - retry: attempt #1 caught exception: timed out 14:26:39 INFO - retry: Failed, sleeping 30 seconds before retrying 14:27:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 14:27:10 INFO - Downloaded 1199 bytes. 14:27:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 14:27:10 INFO - Using the following test package requirements: 14:27:10 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:27:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 14:27:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 14:27:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'jsshell-mac.zip'], 14:27:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 14:27:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 14:27:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 14:27:10 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 14:27:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 14:27:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 14:27:10 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 14:27:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:27:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:10 INFO - https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:27:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:27:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:27:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:27:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:27:13 INFO - Downloaded 18791313 bytes. 14:27:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:27:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:27:16 INFO - Return code: 0 14:27:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:16 INFO - https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 14:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:27:17 INFO - Downloaded 18791313 bytes. 14:27:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:27:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:27:20 INFO - Return code: 0 14:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:20 INFO - https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:27:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:27:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:27:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 14:27:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:27:21 INFO - Downloaded 14405327 bytes. 14:27:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:27:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 14:27:22 INFO - Return code: 0 14:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:22 INFO - https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:27:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:27:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:27:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 14:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 14:27:25 INFO - Downloaded 112441580 bytes. 14:27:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:27:25 INFO - mkdir: /builds/slave/test/properties 14:27:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:27:25 INFO - Writing to file /builds/slave/test/properties/build_url 14:27:25 INFO - Contents: 14:27:25 INFO - build_url:https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 14:27:26 INFO - Running post-action listener: _resource_record_post_action 14:27:26 INFO - Running post-action listener: set_extra_try_arguments 14:27:26 INFO - ##### 14:27:26 INFO - ##### Finished download-and-extract step (success) 14:27:26 INFO - ##### 14:27:26 INFO - ##### 14:27:26 INFO - ##### Running populate-webroot step. 14:27:26 INFO - ##### 14:27:26 INFO - Running pre-action listener: _resource_record_pre_action 14:27:26 INFO - Running main action method: populate_webroot 14:27:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:27:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:27:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:27:26 INFO - '--tppagecycles', 14:27:26 INFO - '7'], 14:27:26 INFO - 'tests': ['tsvgm']}}, 14:27:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:27:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:27:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:27:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:27:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:27:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['damp', 'tps']}, 14:27:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'tests': ['damp', 'tps']}, 14:27:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['dromaeo_dom']}, 14:27:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:27:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['basic_compositor_video']}, 14:27:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:27:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['a11yr', 14:27:26 INFO - 'ts_paint', 14:27:26 INFO - 'tpaint', 14:27:26 INFO - 'sessionrestore', 14:27:26 INFO - 'sessionrestore_no_auto_restore', 14:27:26 INFO - 'tabpaint']}, 14:27:26 INFO - 'other-e10s': {'tests': ['a11yr', 14:27:26 INFO - 'ts_paint', 14:27:26 INFO - 'tpaint', 14:27:26 INFO - 'sessionrestore', 14:27:26 INFO - 'sessionrestore_no_auto_restore', 14:27:26 INFO - 'tabpaint']}, 14:27:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:27:26 INFO - 'ts_paint', 14:27:26 INFO - 'tpaint', 14:27:26 INFO - 'sessionrestore', 14:27:26 INFO - 'sessionrestore_no_auto_restore', 14:27:26 INFO - 'tabpaint']}, 14:27:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:27:26 INFO - 'ts_paint', 14:27:26 INFO - 'tpaint', 14:27:26 INFO - 'sessionrestore', 14:27:26 INFO - 'sessionrestore_no_auto_restore', 14:27:26 INFO - 'tabpaint']}, 14:27:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['a11yr', 14:27:26 INFO - 'ts_paint', 14:27:26 INFO - 'tpaint', 14:27:26 INFO - 'sessionrestore', 14:27:26 INFO - 'sessionrestore_no_auto_restore', 14:27:26 INFO - 'tabpaint']}, 14:27:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['a11yr', 14:27:26 INFO - 'ts_paint', 14:27:26 INFO - 'tpaint', 14:27:26 INFO - 'sessionrestore', 14:27:26 INFO - 'sessionrestore_no_auto_restore', 14:27:26 INFO - 'tabpaint']}, 14:27:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['tsvgx', 14:27:26 INFO - 'tsvgr_opacity', 14:27:26 INFO - 'tart', 14:27:26 INFO - 'tscrollx', 14:27:26 INFO - 'cart']}, 14:27:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:27:26 INFO - 'tsvgr_opacity', 14:27:26 INFO - 'tart', 14:27:26 INFO - 'tscrollx', 14:27:26 INFO - 'cart']}, 14:27:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'talos_options': ['--disable-e10s'], 14:27:26 INFO - 'tests': ['tp5o']}, 14:27:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'tests': ['tp5o']}, 14:27:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'talos_options': ['--disable-e10s', 14:27:26 INFO - '--xperf_path', 14:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:26 INFO - 'tests': ['tp5n']}, 14:27:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:27:26 INFO - 'talos_options': ['--xperf_path', 14:27:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:27:26 INFO - 'tests': ['tp5n']}}, 14:27:26 INFO - 'talos.zip': {'path': '', 14:27:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:27:26 INFO - Running post-action listener: _resource_record_post_action 14:27:26 INFO - ##### 14:27:26 INFO - ##### Finished populate-webroot step (success) 14:27:26 INFO - ##### 14:27:26 INFO - ##### 14:27:26 INFO - ##### Running create-virtualenv step. 14:27:26 INFO - ##### 14:27:26 INFO - Running pre-action listener: _resource_record_pre_action 14:27:26 INFO - Running main action method: create_virtualenv 14:27:26 INFO - Creating virtualenv /builds/slave/test/build/venv 14:27:26 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 14:27:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:27:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:27:26 INFO - Using real prefix '/tools/python27' 14:27:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:27:27 INFO - Installing distribute.............................................................................................................................................................................................done. 14:27:30 INFO - Installing pip.................done. 14:27:30 INFO - Return code: 0 14:27:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:30 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:30 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 14:27:30 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 14:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:30 INFO - 'HOME': '/Users/cltbld', 14:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:30 INFO - 'LOGNAME': 'cltbld', 14:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:30 INFO - 'MOZ_NO_REMOTE': '1', 14:27:30 INFO - 'NO_EM_RESTART': '1', 14:27:30 INFO - 'PAGER': '/bin/cat', 14:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:30 INFO - 'PWD': '/builds/slave/test', 14:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:30 INFO - 'SHELL': '/bin/bash', 14:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:30 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:30 INFO - 'USER': 'cltbld', 14:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:30 INFO - 'XPC_FLAGS': '0x0', 14:27:30 INFO - 'XPC_SERVICE_NAME': '0', 14:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:30 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 14:27:30 INFO - Cleaning up... 14:27:30 INFO - Return code: 0 14:27:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:30 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:30 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 14:27:30 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 14:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:30 INFO - 'HOME': '/Users/cltbld', 14:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:30 INFO - 'LOGNAME': 'cltbld', 14:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:30 INFO - 'MOZ_NO_REMOTE': '1', 14:27:30 INFO - 'NO_EM_RESTART': '1', 14:27:30 INFO - 'PAGER': '/bin/cat', 14:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:30 INFO - 'PWD': '/builds/slave/test', 14:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:30 INFO - 'SHELL': '/bin/bash', 14:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:30 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:30 INFO - 'USER': 'cltbld', 14:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:30 INFO - 'XPC_FLAGS': '0x0', 14:27:30 INFO - 'XPC_SERVICE_NAME': '0', 14:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:30 INFO - Downloading/unpacking psutil>=3.1.1 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:30 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 14:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:27:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:33 INFO - Installing collected packages: psutil 14:27:33 INFO - Running setup.py install for psutil 14:27:34 INFO - building 'psutil._psutil_osx' extension 14:27:34 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 14:27:34 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 14:27:34 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 14:27:34 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 14:27:34 INFO - building 'psutil._psutil_posix' extension 14:27:34 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 14:27:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:27:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:27:34 INFO - ^ 14:27:34 INFO - 1 warning generated. 14:27:34 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 14:27:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:27:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:27:35 INFO - Successfully installed psutil 14:27:35 INFO - Cleaning up... 14:27:35 INFO - Return code: 0 14:27:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:27: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 mozsystemmonitor==0.3 14:27:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:35 INFO - 'HOME': '/Users/cltbld', 14:27:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:35 INFO - 'LOGNAME': 'cltbld', 14:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:35 INFO - 'MOZ_NO_REMOTE': '1', 14:27:35 INFO - 'NO_EM_RESTART': '1', 14:27:35 INFO - 'PAGER': '/bin/cat', 14:27:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:35 INFO - 'PWD': '/builds/slave/test', 14:27:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:35 INFO - 'SHELL': '/bin/bash', 14:27:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:35 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:35 INFO - 'USER': 'cltbld', 14:27:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:35 INFO - 'XPC_FLAGS': '0x0', 14:27:35 INFO - 'XPC_SERVICE_NAME': '0', 14:27:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:27:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:27:38 INFO - Installing collected packages: mozsystemmonitor 14:27:38 INFO - Running setup.py install for mozsystemmonitor 14:27:38 INFO - Successfully installed mozsystemmonitor 14:27:38 INFO - Cleaning up... 14:27:38 INFO - Return code: 0 14:27:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:38 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:38 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 14:27:38 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 14:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:38 INFO - 'HOME': '/Users/cltbld', 14:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:38 INFO - 'LOGNAME': 'cltbld', 14:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:38 INFO - 'MOZ_NO_REMOTE': '1', 14:27:38 INFO - 'NO_EM_RESTART': '1', 14:27:38 INFO - 'PAGER': '/bin/cat', 14:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:38 INFO - 'PWD': '/builds/slave/test', 14:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:38 INFO - 'SHELL': '/bin/bash', 14:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:38 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:38 INFO - 'USER': 'cltbld', 14:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:38 INFO - 'XPC_FLAGS': '0x0', 14:27:38 INFO - 'XPC_SERVICE_NAME': '0', 14:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:38 INFO - Downloading/unpacking jsonschema==2.5.1 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27: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 14:27:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:27:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:27:40 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 14:27:40 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 14:27:40 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 14:27:40 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 14:27:40 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 14:27:40 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 14:27:41 INFO - Downloading functools32-3.2.3-2.tar.gz 14:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:27:41 INFO - warning: no files found matching '*.txt' 14:27:41 INFO - no previously-included directories found matching 'build' 14:27:41 INFO - no previously-included directories found matching 'dist' 14:27:41 INFO - no previously-included directories found matching '.git*' 14:27:41 INFO - Installing collected packages: jsonschema, functools32 14:27:41 INFO - Running setup.py install for functools32 14:27:41 INFO - warning: no files found matching '*.txt' 14:27:41 INFO - no previously-included directories found matching 'build' 14:27:41 INFO - no previously-included directories found matching 'dist' 14:27:41 INFO - no previously-included directories found matching '.git*' 14:27:41 INFO - Successfully installed jsonschema functools32 14:27:41 INFO - Cleaning up... 14:27:41 INFO - Return code: 0 14:27:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:41 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:41 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 14:27:41 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 14:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:41 INFO - 'HOME': '/Users/cltbld', 14:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:41 INFO - 'LOGNAME': 'cltbld', 14:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:41 INFO - 'MOZ_NO_REMOTE': '1', 14:27:41 INFO - 'NO_EM_RESTART': '1', 14:27:41 INFO - 'PAGER': '/bin/cat', 14:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:41 INFO - 'PWD': '/builds/slave/test', 14:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:41 INFO - 'SHELL': '/bin/bash', 14:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:41 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:41 INFO - 'USER': 'cltbld', 14:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:41 INFO - 'XPC_FLAGS': '0x0', 14:27:41 INFO - 'XPC_SERVICE_NAME': '0', 14:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:42 INFO - Downloading/unpacking blobuploader==1.2.4 14:27:42 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 14:27:42 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 14:27:42 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 14:27:42 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 14:27:42 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 14:27:42 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 14:27:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:27:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:27:44 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 14:27:44 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 14:27:44 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 14:27:44 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 14:27:44 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 14:27:44 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 14:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:27:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:27:45 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 14:27:45 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 14:27:45 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 14:27:45 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 14:27:45 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 14:27:45 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 14:27:45 INFO - Downloading docopt-0.6.1.tar.gz 14:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:27:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:27:45 INFO - Running setup.py install for blobuploader 14:27:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:27:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:27:45 INFO - Running setup.py install for requests 14:27:46 INFO - Running setup.py install for docopt 14:27:46 INFO - Successfully installed blobuploader requests docopt 14:27:46 INFO - Cleaning up... 14:27:46 INFO - Return code: 0 14:27:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:46 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:46 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 14:27:46 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 14:27:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:46 INFO - 'HOME': '/Users/cltbld', 14:27:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:46 INFO - 'LOGNAME': 'cltbld', 14:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:46 INFO - 'MOZ_NO_REMOTE': '1', 14:27:46 INFO - 'NO_EM_RESTART': '1', 14:27:46 INFO - 'PAGER': '/bin/cat', 14:27:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:46 INFO - 'PWD': '/builds/slave/test', 14:27:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:46 INFO - 'SHELL': '/bin/bash', 14:27:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:46 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:46 INFO - 'USER': 'cltbld', 14:27:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:46 INFO - 'XPC_FLAGS': '0x0', 14:27:46 INFO - 'XPC_SERVICE_NAME': '0', 14:27:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wHHur5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fCyr8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-kYVA7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-UXNK4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4dHoul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-vG9det-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VFmyV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fOYXBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-JITKMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-qNvF05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-dgudVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-7q3DNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-GhboOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4dcDlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-twcoe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wSTAER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:48 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-GZDL76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:27:48 INFO - Running setup.py install for manifestparser 14:27:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:27:48 INFO - Running setup.py install for mozcrash 14:27:49 INFO - Running setup.py install for mozdebug 14:27:49 INFO - Running setup.py install for mozdevice 14:27:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Running setup.py install for mozfile 14:27:49 INFO - Running setup.py install for mozhttpd 14:27:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Running setup.py install for mozinfo 14:27:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Running setup.py install for mozInstall 14:27:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:27:49 INFO - Running setup.py install for mozleak 14:27:50 INFO - Running setup.py install for mozlog 14:27:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:27:50 INFO - Running setup.py install for moznetwork 14:27:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:27:50 INFO - Running setup.py install for mozprocess 14:27:50 INFO - Running setup.py install for mozprofile 14:27:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:27:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:27:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:27:50 INFO - Running setup.py install for mozrunner 14:27:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:27:50 INFO - Running setup.py install for mozscreenshot 14:27:50 INFO - Running setup.py install for moztest 14:27:51 INFO - Running setup.py install for mozversion 14:27:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:27:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:27:51 INFO - Cleaning up... 14:27:51 INFO - Return code: 0 14:27:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:51 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:51 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 14:27:51 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 14:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:51 INFO - 'HOME': '/Users/cltbld', 14:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:51 INFO - 'LOGNAME': 'cltbld', 14:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:51 INFO - 'MOZ_NO_REMOTE': '1', 14:27:51 INFO - 'NO_EM_RESTART': '1', 14:27:51 INFO - 'PAGER': '/bin/cat', 14:27:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:51 INFO - 'PWD': '/builds/slave/test', 14:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:51 INFO - 'SHELL': '/bin/bash', 14:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:51 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:51 INFO - 'USER': 'cltbld', 14:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:51 INFO - 'XPC_FLAGS': '0x0', 14:27:51 INFO - 'XPC_SERVICE_NAME': '0', 14:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:27:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-jwcuIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:27:51 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)) 14:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:27:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-M17HJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:27:51 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)) 14:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:27:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-g1Ie3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:27:51 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)) 14:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:27:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-nL_AkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:27:51 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)) 14:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:27:51 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-IUuASG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-PpDixW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-0lLyNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-CPUijy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-2TC0hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-AXVtAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-P4E6f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-QRVnjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-IULNBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:27:52 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)) 14:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:27:52 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-KxmqSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:53 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-UBU13M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:27:53 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)) 14:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:27:53 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-Lpt81x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:27:53 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)) 14:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:27:53 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-4pk1PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:27:53 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)) 14:27:53 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)) 14:27:53 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)) 14:27:53 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)) 14:27:53 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)) 14:27:53 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)) 14:27:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:27:53 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 14:27:53 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 14:27:53 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 14:27:53 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 14:27:53 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 14:27:53 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 14:27:55 INFO - Downloading blessings-1.6.tar.gz 14:27:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:55 INFO - Installing collected packages: blessings 14:27:55 INFO - Running setup.py install for blessings 14:27:56 INFO - Successfully installed blessings 14:27:56 INFO - Cleaning up... 14:27:56 INFO - Return code: 0 14:27:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:56 INFO - Reading from file tmpfile_stdout 14:27:56 INFO - Current package versions: 14:27:56 INFO - blessings == 1.6 14:27:56 INFO - blobuploader == 1.2.4 14:27:56 INFO - docopt == 0.6.1 14:27:56 INFO - functools32 == 3.2.3-2 14:27:56 INFO - jsonschema == 2.5.1 14:27:56 INFO - manifestparser == 1.1 14:27:56 INFO - mozInstall == 1.12 14:27:56 INFO - mozcrash == 0.17 14:27:56 INFO - mozdebug == 0.1 14:27:56 INFO - mozdevice == 0.48 14:27:56 INFO - mozfile == 1.2 14:27:56 INFO - mozhttpd == 0.7 14:27:56 INFO - mozinfo == 0.9 14:27:56 INFO - mozleak == 0.1 14:27:56 INFO - mozlog == 3.2 14:27:56 INFO - moznetwork == 0.27 14:27:56 INFO - mozprocess == 0.22 14:27:56 INFO - mozprofile == 0.28 14:27:56 INFO - mozrunner == 6.11 14:27:56 INFO - mozscreenshot == 0.1 14:27:56 INFO - mozsystemmonitor == 0.3 14:27:56 INFO - moztest == 0.7 14:27:56 INFO - mozversion == 1.4 14:27:56 INFO - psutil == 3.1.1 14:27:56 INFO - requests == 1.2.3 14:27:56 INFO - wsgiref == 0.1.2 14:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:56 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 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:56 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 14:27:56 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 14:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:56 INFO - 'HOME': '/Users/cltbld', 14:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:56 INFO - 'LOGNAME': 'cltbld', 14:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:56 INFO - 'MOZ_NO_REMOTE': '1', 14:27:56 INFO - 'NO_EM_RESTART': '1', 14:27:56 INFO - 'PAGER': '/bin/cat', 14:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:56 INFO - 'PWD': '/builds/slave/test', 14:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:56 INFO - 'SHELL': '/bin/bash', 14:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:56 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:56 INFO - 'USER': 'cltbld', 14:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:56 INFO - 'XPC_FLAGS': '0x0', 14:27:56 INFO - 'XPC_SERVICE_NAME': '0', 14:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 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)) 14:27:56 INFO - Cleaning up... 14:27:56 INFO - Return code: 0 14:27:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff359d4a9f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, '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.BXhW7JlwiX/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.mABe2r23KS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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 14:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:56 INFO - 'HOME': '/Users/cltbld', 14:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:56 INFO - 'LOGNAME': 'cltbld', 14:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:56 INFO - 'MOZ_NO_REMOTE': '1', 14:27:56 INFO - 'NO_EM_RESTART': '1', 14:27:56 INFO - 'PAGER': '/bin/cat', 14:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:56 INFO - 'PWD': '/builds/slave/test', 14:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:56 INFO - 'SHELL': '/bin/bash', 14:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:27:56 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:56 INFO - 'USER': 'cltbld', 14:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:56 INFO - 'XPC_FLAGS': '0x0', 14:27:56 INFO - 'XPC_SERVICE_NAME': '0', 14:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:27:56 INFO - Cleaning up... 14:27:57 INFO - Return code: 0 14:27:57 INFO - Running post-action listener: _resource_record_post_action 14:27:57 INFO - Running post-action listener: _start_resource_monitoring 14:27:57 INFO - Starting resource monitoring. 14:27:57 INFO - ##### 14:27:57 INFO - ##### Finished create-virtualenv step (success) 14:27:57 INFO - ##### 14:27:57 INFO - ##### 14:27:57 INFO - ##### Running install step. 14:27:57 INFO - ##### 14:27:57 INFO - Running pre-action listener: _resource_record_pre_action 14:27:57 INFO - Running main action method: install 14:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:57 INFO - Reading from file tmpfile_stdout 14:27:57 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:57 INFO - Reading from file tmpfile_stdout 14:27:57 INFO - Output received: 14:27:57 INFO - Usage: mozinstall [options] installer 14:27:57 INFO - Options: 14:27:57 INFO - -h, --help show this help message and exit 14:27:57 INFO - -d DEST, --destination=DEST 14:27:57 INFO - Directory to install application into. [default: 14:27:57 INFO - "/builds/slave/test"] 14:27:57 INFO - --app=APP Application being installed. [default: firefox] 14:27:57 INFO - mkdir: /builds/slave/test/build/application 14:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:28:32 INFO - Reading from file tmpfile_stdout 14:28:32 INFO - Output received: 14:28:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:28:32 INFO - Running post-action listener: _resource_record_post_action 14:28:32 INFO - ##### 14:28:32 INFO - ##### Finished install step (success) 14:28:32 INFO - ##### 14:28:32 INFO - ##### 14:28:32 INFO - ##### Running run-tests step. 14:28:32 INFO - ##### 14:28:32 INFO - Running pre-action listener: _resource_record_pre_action 14:28:32 INFO - Running main action method: run_tests 14:28:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:28:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:28:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:28:32 INFO - 2016-07-02 14:28:32.036 screenresolution[1645:10263] starting screenresolution argv=screenresolution get 14:28:32 INFO - 2016-07-02 14:28:32.038 screenresolution[1645:10263] Display 0: 1600x1200x32@60 14:28:32 INFO - 2016-07-02 14:28:32.043 screenresolution[1646:10265] starting screenresolution argv=screenresolution list 14:28:32 INFO - Available Modes on Display 0 14:28:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:28:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:28:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:28:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:28:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:28:32 INFO - Intel Iris: 14:28:32 INFO - Chipset Model: Intel Iris 14:28:32 INFO - Type: GPU 14:28:32 INFO - Bus: Built-In 14:28:32 INFO - VRAM (Dynamic, Max): 1536 MB 14:28:32 INFO - Vendor: Intel (0x8086) 14:28:32 INFO - Device ID: 0x0a2e 14:28:32 INFO - Revision ID: 0x0009 14:28:32 INFO - Displays: 14:28:32 INFO - Display: 14:28:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:28:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:28:32 INFO - Display Serial Number: 1600x1200 60 14:28:32 INFO - Main Display: Yes 14:28:32 INFO - Mirror: Off 14:28:32 INFO - Online: Yes 14:28:32 INFO - Rotation: Supported 14:28:32 INFO - Return code: 0 14:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:28:32 INFO - Python 2.7.3 14:28:32 INFO - Return code: 0 14:28:32 INFO - grabbing minidump binary from tooltool 14:28:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:28:32 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 0x10b5e3d30>, '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 0x10b348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b5dbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:28:32 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 14:28:32 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 14:28:32 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 14:28:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:28:32 INFO - Return code: 0 14:28:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:28:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:28:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:28:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:28:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:28:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:28:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:28:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BXhW7JlwiX/Render', 14:28:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:28:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:28:32 INFO - 'HOME': '/Users/cltbld', 14:28:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:28:32 INFO - 'LOGNAME': 'cltbld', 14:28:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:28:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:28:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:28:32 INFO - 'MOZ_NO_REMOTE': '1', 14:28:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:28:32 INFO - 'NO_EM_RESTART': '1', 14:28:32 INFO - 'PAGER': '/bin/cat', 14:28:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:28:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:28:32 INFO - 'PWD': '/builds/slave/test', 14:28:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:28:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:28:32 INFO - 'SHELL': '/bin/bash', 14:28:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mABe2r23KS/Listeners', 14:28:32 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 14:28:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:28:32 INFO - 'USER': 'cltbld', 14:28:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:28:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:28:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:28:32 INFO - 'XPC_FLAGS': '0x0', 14:28:32 INFO - 'XPC_SERVICE_NAME': '0', 14:28:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:28:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:28:32 INFO - mozversion application_buildid: 20160702122623 14:28:32 INFO - mozversion application_changeset: d4379d1513fd8d0702fcaa458d26e00c599eebef 14:28:32 INFO - mozversion application_display_name: Nightly 14:28:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:28:32 INFO - mozversion application_name: Firefox 14:28:32 INFO - mozversion application_remotingname: firefox 14:28:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:28:32 INFO - mozversion application_vendor: Mozilla 14:28:32 INFO - mozversion application_version: 50.0a1 14:28:32 INFO - mozversion platform_buildid: 20160702122623 14:28:32 INFO - mozversion platform_changeset: d4379d1513fd8d0702fcaa458d26e00c599eebef 14:28:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:28:32 INFO - mozversion platform_version: 50.0a1 14:28:32 INFO - using testdate: 1467494912 14:28:32 INFO - actual date: 1467494912 14:28:32 INFO - starting webserver on 'localhost:49272' 14:28:32 INFO - SUITE-START | Running 2 tests 14:28:32 INFO - TEST-START | dromaeo_css 14:28:32 INFO - operating with platform_type : mac_ 14:28:32 INFO - Initialising browser for dromaeo_css test... 14:28:32 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpKQUFmo/profile http://localhost:49272/getInfo.html) 14:28:35 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 14:28:35 INFO - PROCESS | 1656 | colorDepth:24 14:28:35 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 14:28:35 INFO - PROCESS | 1656 | __metrics 14:28:35 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:28:35 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:28:35 INFO - TEST-INFO | 1656: exit 0 14:28:35 INFO - Browser initialized. 14:28:35 INFO - Running cycle 1/1 for dromaeo_css test... 14:28:35 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpKQUFmo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:47 INFO - PROCESS | 1659 | RSS: Main: 243875840 14:28:47 INFO - PROCESS | 1659 | 14:29:39 INFO - PROCESS | 1659 | 1467494979386 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] 14:31:49 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 14:31:51 INFO - PROCESS | 1659 | RSS: Main: 376020992 14:31:51 INFO - PROCESS | 1659 | 14:34:54 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 14:34:55 INFO - PROCESS | 1659 | RSS: Main: 382967808 14:34:55 INFO - PROCESS | 1659 | 14:37:57 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 14:37:57 INFO - PROCESS | 1659 | RSS: Main: 372670464 14:37:57 INFO - PROCESS | 1659 | 14:41:00 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 14:41:00 INFO - PROCESS | 1659 | RSS: Main: 369332224 14:41:00 INFO - PROCESS | 1659 | 14:44:04 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 14:44:04 INFO - PROCESS | 1659 | RSS: Main: 354033664 14:44:04 INFO - PROCESS | 1659 | 14:47:07 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 14:47:08 INFO - PROCESS | 1659 | RSS: Main: 385900544 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | __start_tp_report 14:47:08 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 14:47:08 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 14:47:08 INFO - PROCESS | 1659 | |i|pagename|runs| 14:47:08 INFO - PROCESS | 1659 | |0;dojo.html;3347.447671134263;3369.8820541281043;3372.0221135870597;3387.6104248011484;3445.069831145589;5582.051051321275;5626.437356264377;5678.545716342693;5683.175939488777;5703;5658.094704847225;5659.547236221103;5762.6254293471;5823.359430462657;5836.095405212188;5109.821156259532;5130.51260130287;5195.818146364878;5205.843824685266;5271.683698978054;5248.212768084799;5283.049051170788;5303.124984377573;5306;5332.760025798849;4181.28918083925;5163.8192663256605;5178.223266510016;5182.404023537266;5216.2958000669805;5181.974090129563;5198.428172900978;5201.791928322863;5212.061828870802;5245.055889939809;5180.792768289264;5205.141151709963;5229.294045303874;5274.7626356814035;5278.577713782888;5618.269624948772;5630;5693.516051135658;5705.971470142665;5724.914126288109;6220.222472190976;6243.406876346739;6243.968780156116;6252.6561039142825;6258.718357673915;6261.843453913643;6312.968435157794;6313.905291420632;6328.841778955563;6343.365663433666;5629.662220266756;5730.455606717355;5782.392848750905;5792.0732682771395;5810;6340.841478963062;6352.6823658816875;6372.426481616677;6378.138951241523;6389.265234498;5918.319393269743;6141.6007959482495;6142.969285153635;6155.199824022849;6157;6123.8162855114415;6126.761967422298;6161.507079433634;6194.659293738888;6271.498280137578;6130.969345153246;6181.103739957771;6192.287886892975;6197.442230199304;6215.689215539205;6180.536459765535;6257.7809776658505;6269.96865015672;6272.435480806749;6274.498040156776;4824.131656301899;4846.588040016638;4856.295837103671;4910.386201724785;4915.48387419323;4404.933925991113;4442.222611043119;4458.665600080007;4469.709468884512;4472.686911916199;5679.403662615366;5684.54523638108;5687.886242275132;5691.9146212806845;5716.5998380113;6259.029850373199;6276.623402595859;6284.465820405226;6302.65335406557;6321.715522801485;5554.111342185231;5608.663480191201;5611.242482264842;5693.117566777156;5738;5388;5389.353277606712;5394.433584473573;5397.892042159135;5401.5948803839865;6226.097215903759;6272.8118156455375;6282.811515654537;6317.526185536103;6345.428911397997;6245;6273.466755325849;6287.559870808999;6291.559590828781;6292.370762923671;6308.306086330592;6316.178896743394;6322;6335;6339.302676705651;5726.0838265877255;6031.849203769941;6087.4521293083835;6114.908276375947;6143.078538219303;5740.880528297109;5816.883662326645;6298.842528936813;6299.244090709144;6313.273973493107;4666.650001249987;5980.9401905980385;6054;6081.300650425081;6081.817545473643;5872.207252020922;5949.345571986992;5970.5522085844605;6052.394760523913;6061.909071363845;5933.673647949404;5943.970280148572;5956.851078723066;5965.8806823862415;5978.910316345171;6094.042265292216;6106.877862442815;6109.3599292013505;6131.264248290056;6141.486007784186;5778.133280008033;5820.563457740602;5847.619904706181;5890.558208134493;5946.851328716817 14:47:08 INFO - PROCESS | 1659 | |1;ext.html;470.9882252943676;518.3675915383233;535.2907397698049;547.2693953571982;556.7049463784195;29591;31533.369332613333;31615.841920790423;41239;42106.78946605263;36186.09534761632;43766;43926.682199534065;44034.7798261009;44060.779696101556;9651.806963860736;9800.558974846113;9806.264530160232;9812.018798120202;9822.165115965152;8723;8909.376343655947;9673.467959262238;11736.413179341042;11993.64019079429;11928;11968;12001.33992630405;12017.759644807098;12019.819702704466;8669.566521673954;11753.471093800757;11782.116341274354;11808.704782380424;11811.17321787471;8606.655733770642;8794.824103517894;8805;11469.025132863717;11769.41152942358;41392.379114313306;41853;41860.581394185974;41871.58128418707;41903.7904810474;3444.5522082129414;3488.529048578435;3791.810409479515;4010.6791456683395;4215.978920105411;31300.686993130006;32456.513152302734;32691.182720432178;32791.50812737811;33034.17414564631;3321.2527181383994;3337.0489410517885;3348.815815130167;3388.0852169914233;3431.9485207721905;507154.4642276802;513068;513424;513686;513885;49410.752946235036;60645.78708425807;60818;61043;61097;64420;64422.35577644163;64512.35487645157;64622;64649;15918.442854500037;16414.343426262814;16414.6717065658;16443.83556164423;16452.588685282724;11576.016038636642;11760.705982350339;12808.615741527768;12891.935540322238;12894.548690795777;16316.673666526603;16353.182340883146;16701.830871839098;16959.576010599587;17046;6141.92516309653;7252.5648461092505;7281.490295679251;7286.599237042014;7319;892.1970226795936;1036.8237399642078;1041.9218558608134;1055.1084333737979;1055.9894401055892;30222.395552088834;30347.848260758554;30462.39075218483;30880.53679194814;30957.380852382827;999.6601155606983;1000.5747557288123;1064.5688496159069;1093.4969913839564;1131.1177281720272;15811.604709882346;15815.920920395325;15844.68310633804;16170.434034808724;16217.51347459578;667670;667745;670890;672339;673342;59659;59708.40291597115;59728.70135649294;59900;60088.49778755566;1247.9625611231677;1257.6478585995935;1367.0703921333588;1413.9575812725634;1418.2908545727137;29135.417291654474;29654.851725741235;31454.213644659067;31510.527342090347;32542.34915301728;50326;50740.49259507358;51436.74281628568;51503;51578.22632660438;549613;552990;553426;554298;555385;33634;34636.480452792726;39969.00077497969;40780.38829417502;42240.577594224895;39121;49030.75484622554;49417.011659767326;49481.752591236815;49967.25049124193;38524.614753853224;40357.596424035386;40726.38910416287;41560.1687966245;41675.583244167174;40208.798956006205;40251;40496;40530.79734601308;41499.58500415078;38423.2315353697;38736.80631596937;39351.60648393594;39360;39466.802665986484;32848.67151328552;33398.666013339556;34297.48553771745;34968.38979136721;35498.11254718549;24362.51274974526;25435;25544.489110218063;26064.609030864933;26231.475370492102 14:47:08 INFO - PROCESS | 1659 | |2;jquery.html;350.4218040233616;370.30013274910414;380.1712267257379;382.32710429643816;398.97606143631384;15614.843851561482;16384;20534.691979620282;21002.579948401024;21013.894930525345;20625.690614640793;21188;21251;21326.46683832901;21515.67726484104;5513.393526712059;5778.335491418488;6000.519958403317;6006.309274433453;6667.266600673922;6604.844152273357;6617.735290588371;6687.130673012502;6695.899561506581;6703.1956165260235;5920.407959204067;6351.9047214291595;6631.966840165793;6641.6015039097565;6641.900371494431;6274.56078074535;6474.255460622018;6563;6568.1789776277965;6572.671366431659;5643.379228284885;5662.263905692274;5667.206591077212;5668.489835914746;5677.716114194273;26314.60528092061;26363;26586.46827063448;26922.5961610576;26953;2278.2481781012393;2313.9190128345595;2642.0356569852056;2707.2284398946204;3115.813051216934;9170.220531254852;9681;10197.74505637365;10214.233932455021;15843.841561584468;1683.8652907767348;1858.8048254933308;1920.2990908318363;1964.5972575621963;1993.7308463357406;118980.81019189784;119642.4017879905;119799.4010029953;119925;120397.39801301026;11549.307041577533;11615.477303521362;11639.941800290944;11843.526258949545;12063.396830158457;14170.504032358818;14356.85643143576;14375.568732938029;14434.989550731349;14456;8373.665053397917;8492.065872753992;8533.914660853436;8633.654653813903;8645.740627781177;7450.627468626547;8478;8478.152184781473;8484.533350665773;8624.266937310398;4421.292593185075;4502.729836209838;4521.344405061248;4561.566651168134;4563.498015218323;1778.3283713309706;1795.1831916477972;1907.256170093637;1907.904604769756;1908.723235130926;846.6782622603495;907.1563445995156;953.4327075390132;1005.2058873490007;1044.8432735089646;20866.791332086486;21392.358229253146;21404.678929816066;21408;21464.141434342764;923.2152670230385;946.068122898944;969.8593703912893;973.6154219083422;1031.9587216511256;10934.234603577832;11363.886361136283;11401.258918170459;11405.258658187191;11421.714457138638;440960;495319;496795.0320496821;514825;538486;128421.35789320993;129243;131571.34214328867;132049;132371;961.8028304197622;962.0667952086465;979.583676937313;982.4203719805349;983.695054533097;18797.436076917715;18986.715199271744;19026.809731902504;19035.904820475807;19167.61664766669;41926.79036604797;55958.44041559532;56375.71812140913;56824;57030;75009;76968;79296;81533;81549;8123.5532045738055;8170.264676178935;8266.875996860172;8269.586520674062;8478.872816907628;11076.39079850616;12651.936740316607;12910.419031143434;13285.335733213495;13588.864111359155;9762;10686.57253709874;10924.50839712199;11448.198626096426;11716.179867409199;11329.886701132884;11360.829587556358;11419.828702569303;11438.599649012245;11714.589989350332;11651.59219427316;11670.241434306743;11774.52901883915;11809.586664466702;11878.703032424259;7043.36609705129;7347.7795666130105;7396.593187374746;7676.884846727416;8513.659453622033;10032.347897386646;11416.486258118239;11629.24409913353;11804.350760708243;11849.585264516045 14:47:08 INFO - PROCESS | 1659 | |3;mootools.html;1368.2064402646465;1517.2565442932967;1552.0454920224063;1745.9563510912233;1900.4583693647305;7713.768586942387;8524.957375213124;8720.825583488326;8732.30141588673;8875.64497420104;8506.574671266442;8739.650413983432;8756.211940925316;8761.912380876189;8773.473591584509;2361.0791791201405;2391.0913852735935;2392.808575313971;2397.736249012616;2397.940051498718;2352.9764702352927;2365.7989070928907;2390.175389490623;2392.9880350598223;2393.772591603795;2337.1352599538195;2366.077229880348;2376.66726658268;2381.368937231635;2386.904523819045;2326.8254880883833;2349.706286714161;2358.882055897207;2366.7514910934447;2368.1829768729763;2270.1146552844402;2354.623260278347;2355.1756885090253;2359.5634807560655;2360.280114565074;7909;8172.713955011546;8828;8842.646294148226;8893.644254229823;5145.176771716508;5307.761150748225;5311.920321195185;5335.039692855285;5357.43746906577;3594.4428613564937;3598.280343931198;3669.7614655047337;3672.8530858765616;3680.8159592020293;1043.7475029963998;1052.168786658539;1063.1388575254068;1074.4037059432012;1088.3415533602215;11622.825657615143;11747.412629368582;11753.706157346134;11758.70603234926;11777.234479758874;4594.264917613166;4631.490536041033;4851.078295123985;4855.344528488679;4866.367372241586;9324.487153206639;9511.715918351072;10172.28793984414;10174.847377289347;10200.132988695896;5409.594280428905;5412.675239485643;5418.620696551204;5423.159410291411;5427.864303392446;4895.412550493964;4905.858001446391;4939.53074457926;4958.628102892298;4960.677555958851;3348.9450822991166;3829.942550861739;3846.2307538492414;3930.3121953657997;3967.2065586882163;1213.5206593395735;1267.4423253768311;1270.2886383625014;1273.936303184837;1276.67444801575;900.2303030908479;908.6047569307373;917.1974522292994;935.9969664917082;947.1333729637305;5744.425557444306;5865.472107510344;5942.316633587193;6029.276486821522;6132.264128304632;432.40976067667407;435.7995322151782;437.77892164456745;437.9824807007684;459.9356090147382;4002.399640054015;4035.6771458283265;4094.28350038742;4109.568495308009;4124.05146816234;10301.433421161759;10688.572457101784;10707.785844283071;10869.021788039114;10889.401082940514;10698.251122421356;10800.027997480265;10802;10817.134629229642;10823.783524329627;8095.7166499172245;8293;8296;8305.584720763938;8313.750587482506;5882.1470886722045;6065.878682426415;6083.6045657032155;6233.470155036873;6326.557141000086;9458.43249405038;9858.753531161778;10146.797064058825;10157.288989770645;10252;9936.950315248378;10330.225233107698;10340.844887326846;10384.117350025332;10391.532381043022;7284.344409003215;7595.848083038198;7618.542887426772;7635.350995165251;7738.806529836799;8435.746927592181;8507.064222935596;8577.356698247531;8593.140685931357;8603.741887743377;7471.327580517779;7581;7585.431092668182;7704.499207551491;7725.884111738216;7403.407727381689;7505.962470187614;7515;7669.34810541088;7683.807904802425;7043.225245223124;7062;7087.220405755466;7096.077509923677;7118.039064726196;4892.461829198714;4922.9907868886075;5027.170516864677;5111.718855462986;5115.488451154854;5064.569511591409;5065.113605119016;5068.214426763858;5153.072446959433;5238.869028274324 14:47:08 INFO - PROCESS | 1659 | |4;prototype.html;304.68465138581564;308.04506031302964;313.4358155320424;314.8205522851974;317.91257404213854;5011.94749102688;5036.438704001762;5464.672119672818;5520.144377621465;5548.223248745174;4432.689711720172;4799.760011999395;4953.479884612108;5442.455754424555;5499.945000549993;3961.2275606256862;3994.62051105146;4056.9188616227657;4178.874633760992;4200.768957707325;3722.790093219701;3918.7060970427333;4078.7552746835136;4140.523839758421;4143.8964025899295;3430.5540279763595;4116.423700681907;4157.667386609064;4172.70791044627;4208.768517731523;3944.9802750986205;4007.5992400759983;4017.357222844331;4067.9626695192683;4203.348480985452;2939.8677059532374;3483.860645574174;3567.23304489536;3591.6408359164134;3619.239959608485;4368.912621747547;5336.252924590561;5361.346133663822;5373.785048598052;5375.623706340558;4458.464984201916;4472.932906006413;4579.29021001742;4758.714477131383;4773.546513081252;4925.359703238556;5171.5862730981435;5696;5747.425257474261;5755.460391859018;3503.807290599016;3978.5677156223737;3995.441777706668;4000.4999375078114;4003.319435695939;5333.386640546143;5678.9432105678825;5739.3973632768375;6044.2746870375395;6139.723712432907;3194.4923235260208;3512.0508117994245;3818.3127037133027;4043.9890027493125;4061.6442463371172;3434.6737059979264;4132.876013719533;4137.234611596864;4144.937825932553;4154.646855017358;3941.625545573166;4168.958310416918;4558.475775285885;4769.523047695203;4794.856154315376;4967.130752118364;5686.374498805211;5746.42535746422;5756.913646295309;5785.566082543826;1203.3574171256173;1366.8701473360213;1402.3522361225519;1408.169180183676;1408.218438766474;767.4742801181097;786.8472687512707;810.6797814863214;859.5573279760928;881.4182639457927;4508.346289788028;5184.537344761208;5290.365156181283;5376.865578360573;5399.975009371486;4652.767361631905;5899.439553242435;5915.875983563109;5941.287045554474;5944.295345617734;4182.5750671232345;5321.521063104262;5369;5397.4062853086125;5421.756020979065;3072.3548054908274;3089.58290630762;3106.1923899785766;3106.751459883204;3109.9844500777353;6110.663913484801;6138.478229350555;6155.153453963793;6157.507399408037;6167.660484023997;4999.800007999639;5116.769745361467;5571.860703482445;5808.912866307009;5940.940590594125;6123.84690382744;6125.693715314216;6138.631682099178;6165.290991535941;6206.710443464971;5597.137974797377;5918;5947.264258440992;5973.313068997121;6034.2155519782145;4897.975510122569;5475.330024342614;5932.377100404396;5934.4273767450795;5982.4316689914385;6208.720607572761;6226.62640241587;6260.154879091265;6260.68696565179;6263.185785847811;2994.520876659724;3102.193429708247;4016.8192431341245;4039.8586049488126;4048.736832105904;5227.320448341691;6052.334243233329;6069.787557435468;6072.392760723892;6091.573589848668;4834.863807005421;4921.557059864629;5618.185363122406;5874.295084589877;5896.469317761422;4660.1145782301255;4977.502249774993;5341.50437877395;5552.472515111058;5774.335951365479;5155.845324640267;5647.88704225905;5701.828945131487;5750.108733146369;5763.135529670583;5058.570021548209;5577.749001295033;5630.296212973379;5739.139129130664;5762.798302059407;5601.6358936668985;5648.548116150616;5648.717564121695;5653.773849045992;5680.239125870993 14:47:08 INFO - PROCESS | 1659 | |5;yui.html;708.5217478202212;738.1953670499155;767.3362541401685;773.3697036914914;821.8890449789278;14770.26148692565;15451.536453906372;16051.919740401281;16059.357625694973;16242.7563586546;14344.211068391234;14380.928095359535;14544.418223271083;14552.05411648242;14677.412903483848;700.8458139209366;724.9238829922862;853.9402241843057;879.1779685993585;880.1110878013221;829.8091438969041;880.5377176982072;883.770219742865;884.0187391994881;888.4402826219473;921.6313474610142;930.5672862119113;932.8973812880578;933.3046880074354;935.4761333653142;722.3029776265929;876.5967654878764;925.1165137293868;931.8881734191873;932.5337331334333;688.7623769799411;689.7896141676787;690.0339524665509;691.0981169573704;691.3363171355505;14820.555383338517;14873.405063797436;14883;14907.180105094216;14920.850791492056;13773.104748191336;13803.2408217548;13842.584722458343;13941.442342306296;14217.573472795833;12707.491700331975;12913.67715807103;12969.675758106123;12996.935015324958;13264.137831040951;4500.48244451889;4553.157665831832;4603.953960460386;4609.516000819899;4738.573528382428;101290;105837;112223.87776122298;112471;112575.43712281386;10981.12151027916;11040.447977601249;11092.33445993243;11115.888841111486;11628.302301861915;21711.13155473795;21730.89134554349;21776.673349899764;21780.78219217819;21783.34649960504;7953.204679532117;7979.9601001994615;7984.201579842085;8053.234942680436;8177.632006559719;4402.471703395613;4476.731396116244;4561.315802629632;4580.679352445297;4664.230401983703;3431.69114779671;3544.326577950181;3544.8936531904083;3546.3261980224192;3551.9289614207573;643.06755204953;649.0750680280581;650.5218664281749;659.8779225843139;669.4644284572323;570.7888081409905;595.7451047784202;613.5735663713765;624.9312575616678;626.395528315178;7348.8976653502405;8022.478538894953;8968.372213945091;9011.48054271654;9269.490178040138;597.7280337446451;609.2080295615682;614.8985417406167;620.2494981072953;629.2449061126666;4059.573744756758;4304.3543468479975;4409.096135292258;4415.337699345124;4459.264221403497;86023.56988215144;87036.12963870406;90200;142699.5730042707;146174;123872.38063809623;125401;125797;126952.36523817322;128091.47176754137;108579;108750;109325;109892.4505377468;110047;8580.828383432172;8614.91385086141;8694.391392602458;8818.426802258089;8831.161039701217;55533.167002494185;62090.37909620846;63139.6843015782;63195.6840215796;64981;46703;55621;57231.42768572427;60591.18226453214;70832;13259.80110298327;13403.262820544964;13453.663658408617;13539.323033848465;14012.229327387091;15164.620884477976;15234.847651523343;15257.771133432785;15409.768853466983;15869.04785712861;13694.726105478034;14120.43518259258;14151.292435378396;14256.857431425553;14264.42942282297;12359.814602780785;12472.937635311766;12670.366481676063;12849.421776019915;12900.741985160057;13565.457381704622;13766.65583360424;13769.31153442344;14033.3684984178;14174;10893.673189804318;11563.479643415898;11670.533178672758;11825.290482571074;12151.088668350087;9753.658621948198;10726.302790318605;11472.374315579891;11761.941190293994;11769 14:47:08 INFO - PROCESS | 1659 | __end_tp_report 14:47:08 INFO - PROCESS | 1659 | __start_cc_report 14:47:08 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1273 14:47:08 INFO - PROCESS | 1659 | __end_cc_report 14:47:08 INFO - PROCESS | 1659 | __startTimestamp1467496028151__endTimestamp 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | ------- Summary: start ------- 14:47:08 INFO - PROCESS | 1659 | Number of tests: 6 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5720.46 Median:5872.21 stddev:648.27 (11.0%) stddev-sans-first:622.95 14:47:08 INFO - PROCESS | 1659 | Values: 3347.4 3369.9 3372.0 3387.6 3445.1 5582.1 5626.4 5678.5 5683.2 5703.0 5658.1 5659.5 5762.6 5823.4 5836.1 5109.8 5130.5 5195.8 5205.8 5271.7 5248.2 5283.0 5303.1 5306.0 5332.8 4181.3 5163.8 5178.2 5182.4 5216.3 5182.0 5198.4 5201.8 5212.1 5245.1 5180.8 5205.1 5229.3 5274.8 5278.6 5618.3 5630.0 5693.5 5706.0 5724.9 6220.2 6243.4 6244.0 6252.7 6258.7 6261.8 6313.0 6313.9 6328.8 6343.4 5629.7 5730.5 5782.4 5792.1 5810.0 6340.8 6352.7 6372.4 6378.1 6389.3 5918.3 6141.6 6143.0 6155.2 6157.0 6123.8 6126.8 6161.5 6194.7 6271.5 6131.0 6181.1 6192.3 6197.4 6215.7 6180.5 6257.8 6270.0 6272.4 6274.5 4824.1 4846.6 4856.3 4910.4 4915.5 4404.9 4442.2 4458.7 4469.7 4472.7 5679.4 5684.5 5687.9 5691.9 5716.6 6259.0 6276.6 6284.5 6302.7 6321.7 5554.1 5608.7 5611.2 5693.1 5738.0 5388.0 5389.4 5394.4 5397.9 5401.6 6226.1 6272.8 6282.8 6317.5 6345.4 6245.0 6273.5 6287.6 6291.6 6292.4 6308.3 6316.2 6322.0 6335.0 6339.3 5726.1 6031.8 6087.5 6114.9 6143.1 5740.9 5816.9 6298.8 6299.2 6313.3 4666.7 5980.9 6054.0 6081.3 6081.8 5872.2 5949.3 5970.6 6052.4 6061.9 5933.7 5944.0 5956.9 5965.9 5978.9 6094.0 6106.9 6109.4 6131.3 6141.5 5778.1 5820.6 5847.6 5890.6 5946.9 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:71702.32 Median:39413.40 stddev:155556.95 (394.7%) stddev-sans-first:155901.39 14:47:08 INFO - PROCESS | 1659 | Values: 471.0 518.4 535.3 547.3 556.7 29591.0 31533.4 31615.8 41239.0 42106.8 36186.1 43766.0 43926.7 44034.8 44060.8 9651.8 9800.6 9806.3 9812.0 9822.2 8723.0 8909.4 9673.5 11736.4 11993.6 11928.0 11968.0 12001.3 12017.8 12019.8 8669.6 11753.5 11782.1 11808.7 11811.2 8606.7 8794.8 8805.0 11469.0 11769.4 41392.4 41853.0 41860.6 41871.6 41903.8 3444.6 3488.5 3791.8 4010.7 4216.0 31300.7 32456.5 32691.2 32791.5 33034.2 3321.3 3337.0 3348.8 3388.1 3431.9 507154.5 513068.0 513424.0 513686.0 513885.0 49410.8 60645.8 60818.0 61043.0 61097.0 64420.0 64422.4 64512.4 64622.0 64649.0 15918.4 16414.3 16414.7 16443.8 16452.6 11576.0 11760.7 12808.6 12891.9 12894.5 16316.7 16353.2 16701.8 16959.6 17046.0 6141.9 7252.6 7281.5 7286.6 7319.0 892.2 1036.8 1041.9 1055.1 1056.0 30222.4 30347.8 30462.4 30880.5 30957.4 999.7 1000.6 1064.6 1093.5 1131.1 15811.6 15815.9 15844.7 16170.4 16217.5 667670.0 667745.0 670890.0 672339.0 673342.0 59659.0 59708.4 59728.7 59900.0 60088.5 1248.0 1257.6 1367.1 1414.0 1418.3 29135.4 29654.9 31454.2 31510.5 32542.3 50326.0 50740.5 51436.7 51503.0 51578.2 549613.0 552990.0 553426.0 554298.0 555385.0 33634.0 34636.5 39969.0 40780.4 42240.6 39121.0 49030.8 49417.0 49481.8 49967.3 38524.6 40357.6 40726.4 41560.2 41675.6 40208.8 40251.0 40496.0 40530.8 41499.6 38423.2 38736.8 39351.6 39360.0 39466.8 32848.7 33398.7 34297.5 34968.4 35498.1 24362.5 25435.0 25544.5 26064.6 26231.5 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:32554.38 Median:26754.53 stddev:84373.50 (315.4%) stddev-sans-first:84575.54 14:47:08 INFO - PROCESS | 1659 | Values: 350.4 370.3 380.2 382.3 399.0 15614.8 16384.0 20534.7 21002.6 21013.9 20625.7 21188.0 21251.0 21326.5 21515.7 5513.4 5778.3 6000.5 6006.3 6667.3 6604.8 6617.7 6687.1 6695.9 6703.2 5920.4 6351.9 6632.0 6641.6 6641.9 6274.6 6474.3 6563.0 6568.2 6572.7 5643.4 5662.3 5667.2 5668.5 5677.7 26314.6 26363.0 26586.5 26922.6 26953.0 2278.2 2313.9 2642.0 2707.2 3115.8 9170.2 9681.0 10197.7 10214.2 15843.8 1683.9 1858.8 1920.3 1964.6 1993.7 118980.8 119642.4 119799.4 119925.0 120397.4 11549.3 11615.5 11639.9 11843.5 12063.4 14170.5 14356.9 14375.6 14435.0 14456.0 8373.7 8492.1 8533.9 8633.7 8645.7 7450.6 8478.0 8478.2 8484.5 8624.3 4421.3 4502.7 4521.3 4561.6 4563.5 1778.3 1795.2 1907.3 1907.9 1908.7 846.7 907.2 953.4 1005.2 1044.8 20866.8 21392.4 21404.7 21408.0 21464.1 923.2 946.1 969.9 973.6 1032.0 10934.2 11363.9 11401.3 11405.3 11421.7 440960.0 495319.0 496795.0 514825.0 538486.0 128421.4 129243.0 131571.3 132049.0 132371.0 961.8 962.1 979.6 982.4 983.7 18797.4 18986.7 19026.8 19035.9 19167.6 41926.8 55958.4 56375.7 56824.0 57030.0 75009.0 76968.0 79296.0 81533.0 81549.0 8123.6 8170.3 8266.9 8269.6 8478.9 11076.4 12651.9 12910.4 13285.3 13588.9 9762.0 10686.6 10924.5 11448.2 11716.2 11329.9 11360.8 11419.8 11438.6 11714.6 11651.6 11670.2 11774.5 11809.6 11878.7 7043.4 7347.8 7396.6 7676.9 8513.7 10032.3 11416.5 11629.2 11804.4 11849.6 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5748.60 Median:4893.94 stddev:3232.28 (66.0%) stddev-sans-first:3224.58 14:47:08 INFO - PROCESS | 1659 | Values: 1368.2 1517.3 1552.0 1746.0 1900.5 7713.8 8525.0 8720.8 8732.3 8875.6 8506.6 8739.7 8756.2 8761.9 8773.5 2361.1 2391.1 2392.8 2397.7 2397.9 2353.0 2365.8 2390.2 2393.0 2393.8 2337.1 2366.1 2376.7 2381.4 2386.9 2326.8 2349.7 2358.9 2366.8 2368.2 2270.1 2354.6 2355.2 2359.6 2360.3 7909.0 8172.7 8828.0 8842.6 8893.6 5145.2 5307.8 5311.9 5335.0 5357.4 3594.4 3598.3 3669.8 3672.9 3680.8 1043.7 1052.2 1063.1 1074.4 1088.3 11622.8 11747.4 11753.7 11758.7 11777.2 4594.3 4631.5 4851.1 4855.3 4866.4 9324.5 9511.7 10172.3 10174.8 10200.1 5409.6 5412.7 5418.6 5423.2 5427.9 4895.4 4905.9 4939.5 4958.6 4960.7 3348.9 3829.9 3846.2 3930.3 3967.2 1213.5 1267.4 1270.3 1273.9 1276.7 900.2 908.6 917.2 936.0 947.1 5744.4 5865.5 5942.3 6029.3 6132.3 432.4 435.8 437.8 438.0 459.9 4002.4 4035.7 4094.3 4109.6 4124.1 10301.4 10688.6 10707.8 10869.0 10889.4 10698.3 10800.0 10802.0 10817.1 10823.8 8095.7 8293.0 8296.0 8305.6 8313.8 5882.1 6065.9 6083.6 6233.5 6326.6 9458.4 9858.8 10146.8 10157.3 10252.0 9937.0 10330.2 10340.8 10384.1 10391.5 7284.3 7595.8 7618.5 7635.4 7738.8 8435.7 8507.1 8577.4 8593.1 8603.7 7471.3 7581.0 7585.4 7704.5 7725.9 7403.4 7506.0 7515.0 7669.3 7683.8 7043.2 7062.0 7087.2 7096.1 7118.0 4892.5 4923.0 5027.2 5111.7 5115.5 5064.6 5065.1 5068.2 5153.1 5238.9 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4632.17 Median:5178.06 stddev:1460.50 (28.2%) stddev-sans-first:1428.02 14:47:08 INFO - PROCESS | 1659 | Values: 304.7 308.0 313.4 314.8 317.9 5011.9 5036.4 5464.7 5520.1 5548.2 4432.7 4799.8 4953.5 5442.5 5499.9 3961.2 3994.6 4056.9 4178.9 4200.8 3722.8 3918.7 4078.8 4140.5 4143.9 3430.6 4116.4 4157.7 4172.7 4208.8 3945.0 4007.6 4017.4 4068.0 4203.3 2939.9 3483.9 3567.2 3591.6 3619.2 4368.9 5336.3 5361.3 5373.8 5375.6 4458.5 4472.9 4579.3 4758.7 4773.5 4925.4 5171.6 5696.0 5747.4 5755.5 3503.8 3978.6 3995.4 4000.5 4003.3 5333.4 5678.9 5739.4 6044.3 6139.7 3194.5 3512.1 3818.3 4044.0 4061.6 3434.7 4132.9 4137.2 4144.9 4154.6 3941.6 4169.0 4558.5 4769.5 4794.9 4967.1 5686.4 5746.4 5756.9 5785.6 1203.4 1366.9 1402.4 1408.2 1408.2 767.5 786.8 810.7 859.6 881.4 4508.3 5184.5 5290.4 5376.9 5400.0 4652.8 5899.4 5915.9 5941.3 5944.3 4182.6 5321.5 5369.0 5397.4 5421.8 3072.4 3089.6 3106.2 3106.8 3110.0 6110.7 6138.5 6155.2 6157.5 6167.7 4999.8 5116.8 5571.9 5808.9 5940.9 6123.8 6125.7 6138.6 6165.3 6206.7 5597.1 5918.0 5947.3 5973.3 6034.2 4898.0 5475.3 5932.4 5934.4 5982.4 6208.7 6226.6 6260.2 6260.7 6263.2 2994.5 3102.2 4016.8 4039.9 4048.7 5227.3 6052.3 6069.8 6072.4 6091.6 4834.9 4921.6 5618.2 5874.3 5896.5 4660.1 4977.5 5341.5 5552.5 5774.3 5155.8 5647.9 5701.8 5750.1 5763.1 5058.6 5577.7 5630.3 5739.1 5762.8 5601.6 5648.5 5648.7 5653.8 5680.2 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:22801.66 Median:3805.75 stddev:35216.32 (925.3%) stddev-sans-first:35276.04 14:47:08 INFO - PROCESS | 1659 | Values: 708.5 738.2 767.3 773.4 821.9 14770.3 15451.5 16051.9 16059.4 16242.8 14344.2 14380.9 14544.4 14552.1 14677.4 700.8 724.9 853.9 879.2 880.1 829.8 880.5 883.8 884.0 888.4 921.6 930.6 932.9 933.3 935.5 722.3 876.6 925.1 931.9 932.5 688.8 689.8 690.0 691.1 691.3 14820.6 14873.4 14883.0 14907.2 14920.9 13773.1 13803.2 13842.6 13941.4 14217.6 12707.5 12913.7 12969.7 12996.9 13264.1 4500.5 4553.2 4604.0 4609.5 4738.6 101290.0 105837.0 112223.9 112471.0 112575.4 10981.1 11040.4 11092.3 11115.9 11628.3 21711.1 21730.9 21776.7 21780.8 21783.3 7953.2 7980.0 7984.2 8053.2 8177.6 4402.5 4476.7 4561.3 4580.7 4664.2 3431.7 3544.3 3544.9 3546.3 3551.9 643.1 649.1 650.5 659.9 669.5 570.8 595.7 613.6 624.9 626.4 7348.9 8022.5 8968.4 9011.5 9269.5 597.7 609.2 614.9 620.2 629.2 4059.6 4304.4 4409.1 4415.3 4459.3 86023.6 87036.1 90200.0 142699.6 146174.0 123872.4 125401.0 125797.0 126952.4 128091.5 108579.0 108750.0 109325.0 109892.5 110047.0 8580.8 8614.9 8694.4 8818.4 8831.2 55533.2 62090.4 63139.7 63195.7 64981.0 46703.0 55621.0 57231.4 60591.2 70832.0 13259.8 13403.3 13453.7 13539.3 14012.2 15164.6 15234.8 15257.8 15409.8 15869.0 13694.7 14120.4 14151.3 14256.9 14264.4 12359.8 12472.9 12670.4 12849.4 12900.7 13565.5 13766.7 13769.3 14033.4 14174.0 10893.7 11563.5 11670.5 11825.3 12151.1 9753.7 10726.3 11472.4 11761.9 11769.0 14:47:08 INFO - PROCESS | 1659 | -------- Summary: end -------- 14:47:08 INFO - PROCESS | 1659 | 14:47:08 INFO - TEST-INFO | 1659: exit 0 14:47:08 INFO - TEST-OK | dromaeo_css | took 1116078ms 14:47:08 INFO - TEST-START | kraken 14:47:08 INFO - operating with platform_type : mac_ 14:47:08 INFO - Initialising browser for kraken test... 14:47:08 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmp8J87o3/profile http://localhost:49272/getInfo.html) 14:47:10 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 14:47:10 INFO - PROCESS | 1666 | colorDepth:24 14:47:10 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 14:47:10 INFO - PROCESS | 1666 | __metrics 14:47:10 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:47:10 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:47:11 INFO - TEST-INFO | 1666: exit 0 14:47:11 INFO - Browser initialized. 14:47:11 INFO - Running cycle 1/1 for kraken test... 14:47:11 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmp8J87o3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:47:23 INFO - PROCESS | 1667 | RSS: Main: 244731904 14:47:23 INFO - PROCESS | 1667 | 14:47:26 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 14:47:27 INFO - PROCESS | 1667 | RSS: Main: 294178816 14:47:27 INFO - PROCESS | 1667 | 14:47:29 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 14:47:30 INFO - PROCESS | 1667 | RSS: Main: 304320512 14:47:30 INFO - PROCESS | 1667 | 14:47:33 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 14:47:34 INFO - PROCESS | 1667 | RSS: Main: 389935104 14:47:34 INFO - PROCESS | 1667 | 14:47:36 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 14:47:37 INFO - PROCESS | 1667 | RSS: Main: 290492416 14:47:37 INFO - PROCESS | 1667 | 14:47:39 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:47:39 INFO - PROCESS | 1667 | RSS: Main: 293842944 14:47:39 INFO - PROCESS | 1667 | 14:47:42 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 14:47:43 INFO - PROCESS | 1667 | RSS: Main: 330969088 14:47:43 INFO - PROCESS | 1667 | 14:47:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 14:47:46 INFO - PROCESS | 1667 | RSS: Main: 333971456 14:47:46 INFO - PROCESS | 1667 | 14:47:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 14:47:50 INFO - PROCESS | 1667 | RSS: Main: 332623872 14:47:50 INFO - PROCESS | 1667 | 14:47:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:47:52 INFO - PROCESS | 1667 | RSS: Main: 311848960 14:47:52 INFO - PROCESS | 1667 | 14:47:54 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:47:55 INFO - PROCESS | 1667 | RSS: Main: 319401984 14:47:55 INFO - PROCESS | 1667 | 14:47:57 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:47:58 INFO - PROCESS | 1667 | RSS: Main: 316223488 14:47:58 INFO - PROCESS | 1667 | 14:48:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:48:01 INFO - PROCESS | 1667 | RSS: Main: 326033408 14:48:01 INFO - PROCESS | 1667 | 14:48:04 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:48:05 INFO - PROCESS | 1667 | RSS: Main: 330223616 14:48:05 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 14:48:07 INFO - PROCESS | 1667 | RSS: Main: 373301248 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | __start_tp_report 14:48:07 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 14:48:07 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 14:48:07 INFO - PROCESS | 1667 | |i|pagename|runs| 14:48:07 INFO - PROCESS | 1667 | |0;ai-astar;101;113;114;113;114;112;114;114;113;113 14:48:07 INFO - PROCESS | 1667 | |1;audio-beat-detection;143;107;107;159;107;108;127;107;139;108 14:48:07 INFO - PROCESS | 1667 | |2;audio-dft;182;186;184;184;183;186;183;179;184;185 14:48:07 INFO - PROCESS | 1667 | |3;audio-fft;81;74;57;110;58;57;62;61;129;70 14:48:07 INFO - PROCESS | 1667 | |4;audio-oscillator;82;87;94;70;75;90;131;100;67;101 14:48:07 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;89;87;91;88;89;86;90;88;89;86 14:48:07 INFO - PROCESS | 1667 | |6;imaging-darkroom;96;95;95;97;96;95;95;96;95;95 14:48:07 INFO - PROCESS | 1667 | |7;imaging-desaturate;86;84;91;86;86;82;85;86;83;86 14:48:07 INFO - PROCESS | 1667 | |8;json-parse-financial;55;55;54;55;55;54;54;54;55;55 14:48:07 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;66;69;78;78;73;68;94;107;107;70 14:48:07 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;82;82;94;100;109;70;81;101;106;101 14:48:07 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;151;151;147;137;133;140;142;132;240;152 14:48:07 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;141;216;152;213;230;166;159;159;144;205 14:48:07 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;67;66;70;81;82;86;84;82;82 14:48:07 INFO - PROCESS | 1667 | __end_tp_report 14:48:07 INFO - PROCESS | 1667 | __start_cc_report 14:48:07 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1991 14:48:07 INFO - PROCESS | 1667 | __end_cc_report 14:48:07 INFO - PROCESS | 1667 | __startTimestamp1467496087430__endTimestamp 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | ------- Summary: start ------- 14:48:07 INFO - PROCESS | 1667 | Number of tests: 14 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.96 (3.5%) stddev-sans-first:0.71 14:48:07 INFO - PROCESS | 1667 | Values: 101.0 113.0 114.0 113.0 114.0 112.0 114.0 114.0 113.0 113.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:121.20 Median:117.50 stddev:19.46 (16.6%) stddev-sans-first:18.98 14:48:07 INFO - PROCESS | 1667 | Values: 143.0 107.0 107.0 159.0 107.0 108.0 127.0 107.0 139.0 108.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:2.07 (1.1%) stddev-sans-first:2.11 14:48:07 INFO - PROCESS | 1667 | Values: 182.0 186.0 184.0 184.0 183.0 186.0 183.0 179.0 184.0 185.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:75.90 Median:61.50 stddev:24.71 (40.2%) stddev-sans-first:26.14 14:48:07 INFO - PROCESS | 1667 | Values: 81.0 74.0 57.0 110.0 58.0 57.0 62.0 61.0 129.0 70.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:78.50 stddev:18.69 (23.8%) stddev-sans-first:19.62 14:48:07 INFO - PROCESS | 1667 | Values: 82.0 87.0 94.0 70.0 75.0 90.0 131.0 100.0 67.0 101.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:89.00 stddev:1.64 (1.8%) stddev-sans-first:1.72 14:48:07 INFO - PROCESS | 1667 | Values: 89.0 87.0 91.0 88.0 89.0 86.0 90.0 88.0 89.0 86.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:95.50 Median:95.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 14:48:07 INFO - PROCESS | 1667 | Values: 96.0 95.0 95.0 97.0 96.0 95.0 95.0 96.0 95.0 95.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:2.42 (2.8%) stddev-sans-first:2.55 14:48:07 INFO - PROCESS | 1667 | Values: 86.0 84.0 91.0 86.0 86.0 82.0 85.0 86.0 83.0 86.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:55.00 stddev:0.52 (0.9%) stddev-sans-first:0.53 14:48:07 INFO - PROCESS | 1667 | Values: 55.0 55.0 54.0 55.0 55.0 54.0 54.0 54.0 55.0 55.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:71.50 stddev:15.85 (22.2%) stddev-sans-first:15.86 14:48:07 INFO - PROCESS | 1667 | Values: 66.0 69.0 78.0 78.0 73.0 68.0 94.0 107.0 107.0 70.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:75.50 stddev:12.98 (17.2%) stddev-sans-first:13.19 14:48:07 INFO - PROCESS | 1667 | Values: 82.0 82.0 94.0 100.0 109.0 70.0 81.0 101.0 106.0 101.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:149.00 stddev:31.62 (21.2%) stddev-sans-first:33.53 14:48:07 INFO - PROCESS | 1667 | Values: 151.0 151.0 147.0 137.0 133.0 140.0 142.0 132.0 240.0 152.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:185.50 stddev:33.61 (18.1%) stddev-sans-first:32.79 14:48:07 INFO - PROCESS | 1667 | Values: 141.0 216.0 152.0 213.0 230.0 166.0 159.0 159.0 144.0 205.0 14:48:07 INFO - PROCESS | 1667 | 14:48:07 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:82.00 stddev:8.10 (9.9%) stddev-sans-first:7.79 14:48:07 INFO - PROCESS | 1667 | Values: 67.0 67.0 66.0 70.0 81.0 82.0 86.0 84.0 82.0 82.0 14:48:07 INFO - PROCESS | 1667 | -------- Summary: end -------- 14:48:07 INFO - PROCESS | 1667 | 14:48:08 INFO - TEST-INFO | 1667: exit 0 14:48:08 INFO - TEST-OK | kraken | took 59521ms 14:48:08 INFO - SUITE-END | took 1175s 14:48:08 INFO - Completed test suite (00:19:35) 14:48:08 INFO - javascript benchmark 14:48:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3347.447671134263, 3369.8820541281043, 3372.0221135870597, 3387.6104248011484, 3445.069831145589, 5582.051051321275, 5626.437356264377, 5678.545716342693, 5683.175939488777, 5703.0, 5658.094704847225, 5659.547236221103, 5762.6254293471, 5823.359430462657, 5836.095405212188, 5109.821156259532, 5130.51260130287, 5195.818146364878, 5205.843824685266, 5271.683698978054, 5248.212768084799, 5283.049051170788, 5303.124984377573, 5306.0, 5332.760025798849, 4181.28918083925, 5163.8192663256605, 5178.223266510016, 5182.404023537266, 5216.2958000669805, 5181.974090129563, 5198.428172900978, 5201.791928322863, 5212.061828870802, 5245.055889939809, 5180.792768289264, 5205.141151709963, 5229.294045303874, 5274.7626356814035, 5278.577713782888, 5618.269624948772, 5630.0, 5693.516051135658, 5705.971470142665, 5724.914126288109, 6220.222472190976, 6243.406876346739, 6243.968780156116, 6252.6561039142825, 6258.718357673915, 6261.843453913643, 6312.968435157794, 6313.905291420632, 6328.841778955563, 6343.365663433666, 5629.662220266756, 5730.455606717355, 5782.392848750905, 5792.0732682771395, 5810.0, 6340.841478963062, 6352.6823658816875, 6372.426481616677, 6378.138951241523, 6389.265234498, 5918.319393269743, 6141.6007959482495, 6142.969285153635, 6155.199824022849, 6157.0, 6123.8162855114415, 6126.761967422298, 6161.507079433634, 6194.659293738888, 6271.498280137578, 6130.969345153246, 6181.103739957771, 6192.287886892975, 6197.442230199304, 6215.689215539205, 6180.536459765535, 6257.7809776658505, 6269.96865015672, 6272.435480806749, 6274.498040156776, 4824.131656301899, 4846.588040016638, 4856.295837103671, 4910.386201724785, 4915.48387419323, 4404.933925991113, 4442.222611043119, 4458.665600080007, 4469.709468884512, 4472.686911916199, 5679.403662615366, 5684.54523638108, 5687.886242275132, 5691.9146212806845, 5716.5998380113, 6259.029850373199, 6276.623402595859, 6284.465820405226, 6302.65335406557, 6321.715522801485, 5554.111342185231, 5608.663480191201, 5611.242482264842, 5693.117566777156, 5738.0, 5388.0, 5389.353277606712, 5394.433584473573, 5397.892042159135, 5401.5948803839865, 6226.097215903759, 6272.8118156455375, 6282.811515654537, 6317.526185536103, 6345.428911397997, 6245.0, 6273.466755325849, 6287.559870808999, 6291.559590828781, 6292.370762923671, 6308.306086330592, 6316.178896743394, 6322.0, 6335.0, 6339.302676705651, 5726.0838265877255, 6031.849203769941, 6087.4521293083835, 6114.908276375947, 6143.078538219303, 5740.880528297109, 5816.883662326645, 6298.842528936813, 6299.244090709144, 6313.273973493107, 4666.650001249987, 5980.9401905980385, 6054.0, 6081.300650425081, 6081.817545473643, 5872.207252020922, 5949.345571986992, 5970.5522085844605, 6052.394760523913, 6061.909071363845, 5933.673647949404, 5943.970280148572, 5956.851078723066, 5965.8806823862415, 5978.910316345171, 6094.042265292216, 6106.877862442815, 6109.3599292013505, 6131.264248290056, 6141.486007784186, 5778.133280008033, 5820.563457740602, 5847.619904706181, 5890.558208134493, 5946.851328716817], "value": 5679.268442558945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.9882252943676, 518.3675915383233, 535.2907397698049, 547.2693953571982, 556.7049463784195, 29591.0, 31533.369332613333, 31615.841920790423, 41239.0, 42106.78946605263, 36186.09534761632, 43766.0, 43926.682199534065, 44034.7798261009, 44060.779696101556, 9651.806963860736, 9800.558974846113, 9806.264530160232, 9812.018798120202, 9822.165115965152, 8723.0, 8909.376343655947, 9673.467959262238, 11736.413179341042, 11993.64019079429, 11928.0, 11968.0, 12001.33992630405, 12017.759644807098, 12019.819702704466, 8669.566521673954, 11753.471093800757, 11782.116341274354, 11808.704782380424, 11811.17321787471, 8606.655733770642, 8794.824103517894, 8805.0, 11469.025132863717, 11769.41152942358, 41392.379114313306, 41853.0, 41860.581394185974, 41871.58128418707, 41903.7904810474, 3444.5522082129414, 3488.529048578435, 3791.810409479515, 4010.6791456683395, 4215.978920105411, 31300.686993130006, 32456.513152302734, 32691.182720432178, 32791.50812737811, 33034.17414564631, 3321.2527181383994, 3337.0489410517885, 3348.815815130167, 3388.0852169914233, 3431.9485207721905, 507154.4642276802, 513068.0, 513424.0, 513686.0, 513885.0, 49410.752946235036, 60645.78708425807, 60818.0, 61043.0, 61097.0, 64420.0, 64422.35577644163, 64512.35487645157, 64622.0, 64649.0, 15918.442854500037, 16414.343426262814, 16414.6717065658, 16443.83556164423, 16452.588685282724, 11576.016038636642, 11760.705982350339, 12808.615741527768, 12891.935540322238, 12894.548690795777, 16316.673666526603, 16353.182340883146, 16701.830871839098, 16959.576010599587, 17046.0, 6141.92516309653, 7252.5648461092505, 7281.490295679251, 7286.599237042014, 7319.0, 892.1970226795936, 1036.8237399642078, 1041.9218558608134, 1055.1084333737979, 1055.9894401055892, 30222.395552088834, 30347.848260758554, 30462.39075218483, 30880.53679194814, 30957.380852382827, 999.6601155606983, 1000.5747557288123, 1064.5688496159069, 1093.4969913839564, 1131.1177281720272, 15811.604709882346, 15815.920920395325, 15844.68310633804, 16170.434034808724, 16217.51347459578, 667670.0, 667745.0, 670890.0, 672339.0, 673342.0, 59659.0, 59708.40291597115, 59728.70135649294, 59900.0, 60088.49778755566, 1247.9625611231677, 1257.6478585995935, 1367.0703921333588, 1413.9575812725634, 1418.2908545727137, 29135.417291654474, 29654.851725741235, 31454.213644659067, 31510.527342090347, 32542.34915301728, 50326.0, 50740.49259507358, 51436.74281628568, 51503.0, 51578.22632660438, 549613.0, 552990.0, 553426.0, 554298.0, 555385.0, 33634.0, 34636.480452792726, 39969.00077497969, 40780.38829417502, 42240.577594224895, 39121.0, 49030.75484622554, 49417.011659767326, 49481.752591236815, 49967.25049124193, 38524.614753853224, 40357.596424035386, 40726.38910416287, 41560.1687966245, 41675.583244167174, 40208.798956006205, 40251.0, 40496.0, 40530.79734601308, 41499.58500415078, 38423.2315353697, 38736.80631596937, 39351.60648393594, 39360.0, 39466.802665986484, 32848.67151328552, 33398.666013339556, 34297.48553771745, 34968.38979136721, 35498.11254718549, 24362.51274974526, 25435.0, 25544.489110218063, 26064.609030864933, 26231.475370492102], "value": 20626.08099203098, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.4218040233616, 370.30013274910414, 380.1712267257379, 382.32710429643816, 398.97606143631384, 15614.843851561482, 16384.0, 20534.691979620282, 21002.579948401024, 21013.894930525345, 20625.690614640793, 21188.0, 21251.0, 21326.46683832901, 21515.67726484104, 5513.393526712059, 5778.335491418488, 6000.519958403317, 6006.309274433453, 6667.266600673922, 6604.844152273357, 6617.735290588371, 6687.130673012502, 6695.899561506581, 6703.1956165260235, 5920.407959204067, 6351.9047214291595, 6631.966840165793, 6641.6015039097565, 6641.900371494431, 6274.56078074535, 6474.255460622018, 6563.0, 6568.1789776277965, 6572.671366431659, 5643.379228284885, 5662.263905692274, 5667.206591077212, 5668.489835914746, 5677.716114194273, 26314.60528092061, 26363.0, 26586.46827063448, 26922.5961610576, 26953.0, 2278.2481781012393, 2313.9190128345595, 2642.0356569852056, 2707.2284398946204, 3115.813051216934, 9170.220531254852, 9681.0, 10197.74505637365, 10214.233932455021, 15843.841561584468, 1683.8652907767348, 1858.8048254933308, 1920.2990908318363, 1964.5972575621963, 1993.7308463357406, 118980.81019189784, 119642.4017879905, 119799.4010029953, 119925.0, 120397.39801301026, 11549.307041577533, 11615.477303521362, 11639.941800290944, 11843.526258949545, 12063.396830158457, 14170.504032358818, 14356.85643143576, 14375.568732938029, 14434.989550731349, 14456.0, 8373.665053397917, 8492.065872753992, 8533.914660853436, 8633.654653813903, 8645.740627781177, 7450.627468626547, 8478.0, 8478.152184781473, 8484.533350665773, 8624.266937310398, 4421.292593185075, 4502.729836209838, 4521.344405061248, 4561.566651168134, 4563.498015218323, 1778.3283713309706, 1795.1831916477972, 1907.256170093637, 1907.904604769756, 1908.723235130926, 846.6782622603495, 907.1563445995156, 953.4327075390132, 1005.2058873490007, 1044.8432735089646, 20866.791332086486, 21392.358229253146, 21404.678929816066, 21408.0, 21464.141434342764, 923.2152670230385, 946.068122898944, 969.8593703912893, 973.6154219083422, 1031.9587216511256, 10934.234603577832, 11363.886361136283, 11401.258918170459, 11405.258658187191, 11421.714457138638, 440960.0, 495319.0, 496795.0320496821, 514825.0, 538486.0, 128421.35789320993, 129243.0, 131571.34214328867, 132049.0, 132371.0, 961.8028304197622, 962.0667952086465, 979.583676937313, 982.4203719805349, 983.695054533097, 18797.436076917715, 18986.715199271744, 19026.809731902504, 19035.904820475807, 19167.61664766669, 41926.79036604797, 55958.44041559532, 56375.71812140913, 56824.0, 57030.0, 75009.0, 76968.0, 79296.0, 81533.0, 81549.0, 8123.5532045738055, 8170.264676178935, 8266.875996860172, 8269.586520674062, 8478.872816907628, 11076.39079850616, 12651.936740316607, 12910.419031143434, 13285.335733213495, 13588.864111359155, 9762.0, 10686.57253709874, 10924.50839712199, 11448.198626096426, 11716.179867409199, 11329.886701132884, 11360.829587556358, 11419.828702569303, 11438.599649012245, 11714.589989350332, 11651.59219427316, 11670.241434306743, 11774.52901883915, 11809.586664466702, 11878.703032424259, 7043.36609705129, 7347.7795666130105, 7396.593187374746, 7676.884846727416, 8513.659453622033, 10032.347897386646, 11416.486258118239, 11629.24409913353, 11804.350760708243, 11849.585264516045], "value": 9729.916269062933, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.2064402646465, 1517.2565442932967, 1552.0454920224063, 1745.9563510912233, 1900.4583693647305, 7713.768586942387, 8524.957375213124, 8720.825583488326, 8732.30141588673, 8875.64497420104, 8506.574671266442, 8739.650413983432, 8756.211940925316, 8761.912380876189, 8773.473591584509, 2361.0791791201405, 2391.0913852735935, 2392.808575313971, 2397.736249012616, 2397.940051498718, 2352.9764702352927, 2365.7989070928907, 2390.175389490623, 2392.9880350598223, 2393.772591603795, 2337.1352599538195, 2366.077229880348, 2376.66726658268, 2381.368937231635, 2386.904523819045, 2326.8254880883833, 2349.706286714161, 2358.882055897207, 2366.7514910934447, 2368.1829768729763, 2270.1146552844402, 2354.623260278347, 2355.1756885090253, 2359.5634807560655, 2360.280114565074, 7909.0, 8172.713955011546, 8828.0, 8842.646294148226, 8893.644254229823, 5145.176771716508, 5307.761150748225, 5311.920321195185, 5335.039692855285, 5357.43746906577, 3594.4428613564937, 3598.280343931198, 3669.7614655047337, 3672.8530858765616, 3680.8159592020293, 1043.7475029963998, 1052.168786658539, 1063.1388575254068, 1074.4037059432012, 1088.3415533602215, 11622.825657615143, 11747.412629368582, 11753.706157346134, 11758.70603234926, 11777.234479758874, 4594.264917613166, 4631.490536041033, 4851.078295123985, 4855.344528488679, 4866.367372241586, 9324.487153206639, 9511.715918351072, 10172.28793984414, 10174.847377289347, 10200.132988695896, 5409.594280428905, 5412.675239485643, 5418.620696551204, 5423.159410291411, 5427.864303392446, 4895.412550493964, 4905.858001446391, 4939.53074457926, 4958.628102892298, 4960.677555958851, 3348.9450822991166, 3829.942550861739, 3846.2307538492414, 3930.3121953657997, 3967.2065586882163, 1213.5206593395735, 1267.4423253768311, 1270.2886383625014, 1273.936303184837, 1276.67444801575, 900.2303030908479, 908.6047569307373, 917.1974522292994, 935.9969664917082, 947.1333729637305, 5744.425557444306, 5865.472107510344, 5942.316633587193, 6029.276486821522, 6132.264128304632, 432.40976067667407, 435.7995322151782, 437.77892164456745, 437.9824807007684, 459.9356090147382, 4002.399640054015, 4035.6771458283265, 4094.28350038742, 4109.568495308009, 4124.05146816234, 10301.433421161759, 10688.572457101784, 10707.785844283071, 10869.021788039114, 10889.401082940514, 10698.251122421356, 10800.027997480265, 10802.0, 10817.134629229642, 10823.783524329627, 8095.7166499172245, 8293.0, 8296.0, 8305.584720763938, 8313.750587482506, 5882.1470886722045, 6065.878682426415, 6083.6045657032155, 6233.470155036873, 6326.557141000086, 9458.43249405038, 9858.753531161778, 10146.797064058825, 10157.288989770645, 10252.0, 9936.950315248378, 10330.225233107698, 10340.844887326846, 10384.117350025332, 10391.532381043022, 7284.344409003215, 7595.848083038198, 7618.542887426772, 7635.350995165251, 7738.806529836799, 8435.746927592181, 8507.064222935596, 8577.356698247531, 8593.140685931357, 8603.741887743377, 7471.327580517779, 7581.0, 7585.431092668182, 7704.499207551491, 7725.884111738216, 7403.407727381689, 7505.962470187614, 7515.0, 7669.34810541088, 7683.807904802425, 7043.225245223124, 7062.0, 7087.220405755466, 7096.077509923677, 7118.039064726196, 4892.461829198714, 4922.9907868886075, 5027.170516864677, 5111.718855462986, 5115.488451154854, 5064.569511591409, 5065.113605119016, 5068.214426763858, 5153.072446959433, 5238.869028274324], "value": 4535.925851802532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.68465138581564, 308.04506031302964, 313.4358155320424, 314.8205522851974, 317.91257404213854, 5011.94749102688, 5036.438704001762, 5464.672119672818, 5520.144377621465, 5548.223248745174, 4432.689711720172, 4799.760011999395, 4953.479884612108, 5442.455754424555, 5499.945000549993, 3961.2275606256862, 3994.62051105146, 4056.9188616227657, 4178.874633760992, 4200.768957707325, 3722.790093219701, 3918.7060970427333, 4078.7552746835136, 4140.523839758421, 4143.8964025899295, 3430.5540279763595, 4116.423700681907, 4157.667386609064, 4172.70791044627, 4208.768517731523, 3944.9802750986205, 4007.5992400759983, 4017.357222844331, 4067.9626695192683, 4203.348480985452, 2939.8677059532374, 3483.860645574174, 3567.23304489536, 3591.6408359164134, 3619.239959608485, 4368.912621747547, 5336.252924590561, 5361.346133663822, 5373.785048598052, 5375.623706340558, 4458.464984201916, 4472.932906006413, 4579.29021001742, 4758.714477131383, 4773.546513081252, 4925.359703238556, 5171.5862730981435, 5696.0, 5747.425257474261, 5755.460391859018, 3503.807290599016, 3978.5677156223737, 3995.441777706668, 4000.4999375078114, 4003.319435695939, 5333.386640546143, 5678.9432105678825, 5739.3973632768375, 6044.2746870375395, 6139.723712432907, 3194.4923235260208, 3512.0508117994245, 3818.3127037133027, 4043.9890027493125, 4061.6442463371172, 3434.6737059979264, 4132.876013719533, 4137.234611596864, 4144.937825932553, 4154.646855017358, 3941.625545573166, 4168.958310416918, 4558.475775285885, 4769.523047695203, 4794.856154315376, 4967.130752118364, 5686.374498805211, 5746.42535746422, 5756.913646295309, 5785.566082543826, 1203.3574171256173, 1366.8701473360213, 1402.3522361225519, 1408.169180183676, 1408.218438766474, 767.4742801181097, 786.8472687512707, 810.6797814863214, 859.5573279760928, 881.4182639457927, 4508.346289788028, 5184.537344761208, 5290.365156181283, 5376.865578360573, 5399.975009371486, 4652.767361631905, 5899.439553242435, 5915.875983563109, 5941.287045554474, 5944.295345617734, 4182.5750671232345, 5321.521063104262, 5369.0, 5397.4062853086125, 5421.756020979065, 3072.3548054908274, 3089.58290630762, 3106.1923899785766, 3106.751459883204, 3109.9844500777353, 6110.663913484801, 6138.478229350555, 6155.153453963793, 6157.507399408037, 6167.660484023997, 4999.800007999639, 5116.769745361467, 5571.860703482445, 5808.912866307009, 5940.940590594125, 6123.84690382744, 6125.693715314216, 6138.631682099178, 6165.290991535941, 6206.710443464971, 5597.137974797377, 5918.0, 5947.264258440992, 5973.313068997121, 6034.2155519782145, 4897.975510122569, 5475.330024342614, 5932.377100404396, 5934.4273767450795, 5982.4316689914385, 6208.720607572761, 6226.62640241587, 6260.154879091265, 6260.68696565179, 6263.185785847811, 2994.520876659724, 3102.193429708247, 4016.8192431341245, 4039.8586049488126, 4048.736832105904, 5227.320448341691, 6052.334243233329, 6069.787557435468, 6072.392760723892, 6091.573589848668, 4834.863807005421, 4921.557059864629, 5618.185363122406, 5874.295084589877, 5896.469317761422, 4660.1145782301255, 4977.502249774993, 5341.50437877395, 5552.472515111058, 5774.335951365479, 5155.845324640267, 5647.88704225905, 5701.828945131487, 5750.108733146369, 5763.135529670583, 5058.570021548209, 5577.749001295033, 5630.296212973379, 5739.139129130664, 5762.798302059407, 5601.6358936668985, 5648.548116150616, 5648.717564121695, 5653.773849045992, 5680.239125870993], "value": 4163.378807716129, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5217478202212, 738.1953670499155, 767.3362541401685, 773.3697036914914, 821.8890449789278, 14770.26148692565, 15451.536453906372, 16051.919740401281, 16059.357625694973, 16242.7563586546, 14344.211068391234, 14380.928095359535, 14544.418223271083, 14552.05411648242, 14677.412903483848, 700.8458139209366, 724.9238829922862, 853.9402241843057, 879.1779685993585, 880.1110878013221, 829.8091438969041, 880.5377176982072, 883.770219742865, 884.0187391994881, 888.4402826219473, 921.6313474610142, 930.5672862119113, 932.8973812880578, 933.3046880074354, 935.4761333653142, 722.3029776265929, 876.5967654878764, 925.1165137293868, 931.8881734191873, 932.5337331334333, 688.7623769799411, 689.7896141676787, 690.0339524665509, 691.0981169573704, 691.3363171355505, 14820.555383338517, 14873.405063797436, 14883.0, 14907.180105094216, 14920.850791492056, 13773.104748191336, 13803.2408217548, 13842.584722458343, 13941.442342306296, 14217.573472795833, 12707.491700331975, 12913.67715807103, 12969.675758106123, 12996.935015324958, 13264.137831040951, 4500.48244451889, 4553.157665831832, 4603.953960460386, 4609.516000819899, 4738.573528382428, 101290.0, 105837.0, 112223.87776122298, 112471.0, 112575.43712281386, 10981.12151027916, 11040.447977601249, 11092.33445993243, 11115.888841111486, 11628.302301861915, 21711.13155473795, 21730.89134554349, 21776.673349899764, 21780.78219217819, 21783.34649960504, 7953.204679532117, 7979.9601001994615, 7984.201579842085, 8053.234942680436, 8177.632006559719, 4402.471703395613, 4476.731396116244, 4561.315802629632, 4580.679352445297, 4664.230401983703, 3431.69114779671, 3544.326577950181, 3544.8936531904083, 3546.3261980224192, 3551.9289614207573, 643.06755204953, 649.0750680280581, 650.5218664281749, 659.8779225843139, 669.4644284572323, 570.7888081409905, 595.7451047784202, 613.5735663713765, 624.9312575616678, 626.395528315178, 7348.8976653502405, 8022.478538894953, 8968.372213945091, 9011.48054271654, 9269.490178040138, 597.7280337446451, 609.2080295615682, 614.8985417406167, 620.2494981072953, 629.2449061126666, 4059.573744756758, 4304.3543468479975, 4409.096135292258, 4415.337699345124, 4459.264221403497, 86023.56988215144, 87036.12963870406, 90200.0, 142699.5730042707, 146174.0, 123872.38063809623, 125401.0, 125797.0, 126952.36523817322, 128091.47176754137, 108579.0, 108750.0, 109325.0, 109892.4505377468, 110047.0, 8580.828383432172, 8614.91385086141, 8694.391392602458, 8818.426802258089, 8831.161039701217, 55533.167002494185, 62090.37909620846, 63139.6843015782, 63195.6840215796, 64981.0, 46703.0, 55621.0, 57231.42768572427, 60591.18226453214, 70832.0, 13259.80110298327, 13403.262820544964, 13453.663658408617, 13539.323033848465, 14012.229327387091, 15164.620884477976, 15234.847651523343, 15257.771133432785, 15409.768853466983, 15869.04785712861, 13694.726105478034, 14120.43518259258, 14151.292435378396, 14256.857431425553, 14264.42942282297, 12359.814602780785, 12472.937635311766, 12670.366481676063, 12849.421776019915, 12900.741985160057, 13565.457381704622, 13766.65583360424, 13769.31153442344, 14033.3684984178, 14174.0, 10893.673189804318, 11563.479643415898, 11670.533178672758, 11825.290482571074, 12151.088668350087, 9753.658621948198, 10726.302790318605, 11472.374315579891, 11761.941190293994, 11769.0], "value": 7703.393890496161, "unit": "score"}], "name": "dromaeo_css", "value": 7412.13301638133, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 113.0, 114.0, 113.0, 114.0, 112.0, 114.0, 114.0, 113.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 107.0, 159.0, 107.0, 108.0, 127.0, 107.0, 139.0, 108.0], "value": 121.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 186.0, 184.0, 184.0, 183.0, 186.0, 183.0, 179.0, 184.0, 185.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 57.0, 110.0, 58.0, 57.0, 62.0, 61.0, 129.0, 70.0], "value": 75.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 87.0, 94.0, 70.0, 75.0, 90.0, 131.0, 100.0, 67.0, 101.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 91.0, 88.0, 89.0, 86.0, 90.0, 88.0, 89.0, 86.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 97.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 91.0, 86.0, 86.0, 82.0, 85.0, 86.0, 83.0, 86.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 78.0, 78.0, 73.0, 68.0, 94.0, 107.0, 107.0, 70.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 94.0, 100.0, 109.0, 70.0, 81.0, 101.0, 106.0, 101.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 147.0, 137.0, 133.0, 140.0, 142.0, 132.0, 240.0, 152.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 216.0, 152.0, 213.0, 230.0, 166.0, 159.0, 159.0, 144.0, 205.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 70.0, 81.0, 82.0, 86.0, 84.0, 82.0, 82.0], "value": 76.7, "unit": "score"}], "name": "kraken", "value": 1487.7, "alertThreshold": 2.0}]} 14:48:08 INFO - Return code: 0 14:48:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:48:08 INFO - # TBPL SUCCESS # 14:48:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:48:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:48:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:48:08 INFO - 2016-07-02 14:48:08.752 screenresolution[1671:12437] starting screenresolution argv=screenresolution get 14:48:08 INFO - 2016-07-02 14:48:08.755 screenresolution[1671:12437] Display 0: 1600x1200x32@60 14:48:08 INFO - 2016-07-02 14:48:08.761 screenresolution[1672:12440] starting screenresolution argv=screenresolution list 14:48:08 INFO - Available Modes on Display 0 14:48:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:48:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:48:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:48:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:48:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:48:08 INFO - Intel Iris: 14:48:08 INFO - Chipset Model: Intel Iris 14:48:08 INFO - Type: GPU 14:48:08 INFO - Bus: Built-In 14:48:08 INFO - VRAM (Dynamic, Max): 1536 MB 14:48:08 INFO - Vendor: Intel (0x8086) 14:48:08 INFO - Device ID: 0x0a2e 14:48:08 INFO - Revision ID: 0x0009 14:48:08 INFO - Displays: 14:48:08 INFO - Display: 14:48:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:48:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:48:08 INFO - Display Serial Number: 1600x1200 60 14:48:08 INFO - Main Display: Yes 14:48:08 INFO - Mirror: Off 14:48:08 INFO - Online: Yes 14:48:08 INFO - Rotation: Supported 14:48:08 INFO - Return code: 0 14:48:08 INFO - Running post-action listener: _resource_record_post_action 14:48:08 INFO - ##### 14:48:08 INFO - ##### Finished run-tests step (success) 14:48:08 INFO - ##### 14:48:08 INFO - Running post-run listener: _resource_record_post_run 14:48:09 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 31620608; Write bytes: 705037824; Read time: 193; Write time: 1976 14:48:09 INFO - TinderboxPrint: CPU usage
53.5% 14:48:09 INFO - TinderboxPrint: I/O read bytes / time
31,620,608 / 193 14:48:09 INFO - TinderboxPrint: I/O write bytes / time
705,037,824 / 1,976 14:48:09 INFO - TinderboxPrint: CPU idle
2,252.8 (46.5%) 14:48:09 INFO - TinderboxPrint: CPU system
970.3 (20.0%) 14:48:09 INFO - TinderboxPrint: CPU user
1,622.5 (33.5%) 14:48:09 INFO - TinderboxPrint: Swap in / out
434,446,336 / 0 14:48:09 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 385970688; Write bytes: 379824128; Read time: 29024; Write time: 820 14:48:09 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30707200; Write bytes: 295706112; Read time: 182; Write time: 1086 14:48:09 INFO - Running post-run listener: _upload_blobber_files 14:48:09 INFO - Blob upload gear active. 14:48:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:48:09 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 14:48:09 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:48:09 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:48:09 INFO - (blobuploader) - INFO - Open directory for files ... 14:48:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:48:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:11 INFO - (blobuploader) - INFO - Done attempting. 14:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:11 INFO - (blobuploader) - INFO - Done attempting. 14:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:48:14 INFO - (blobuploader) - INFO - Done attempting. 14:48:14 INFO - (blobuploader) - INFO - Iteration through files over. 14:48:14 INFO - Return code: 0 14:48:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:48:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:48:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/637abc9f39b7d23bb81f4a9b3d8ec47dd668662cf33be51cc5abd5b91756222c9046202ab4c25e769fd2b31aa94761660bdd4f4169ad68c58bf68fc157208f6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8e73d36392d4a313bee3c058dc25091bba8fb9b0cb81351e09666a5729a44bbddb3cd8cb9bfc68497cb83a22a246a8f8d716b1cc7d9e755faa74ae90af906f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e254ac8b21717f8c056c71fe3ee75a0d792c612c2148235d085e5a94a48896e6181b716c95cad0265bbc512ff7a5f065984f27da63ec48ac3634b551fa6d92f"} 14:48:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:48:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:48:14 INFO - Contents: 14:48:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/637abc9f39b7d23bb81f4a9b3d8ec47dd668662cf33be51cc5abd5b91756222c9046202ab4c25e769fd2b31aa94761660bdd4f4169ad68c58bf68fc157208f6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8e73d36392d4a313bee3c058dc25091bba8fb9b0cb81351e09666a5729a44bbddb3cd8cb9bfc68497cb83a22a246a8f8d716b1cc7d9e755faa74ae90af906f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e254ac8b21717f8c056c71fe3ee75a0d792c612c2148235d085e5a94a48896e6181b716c95cad0265bbc512ff7a5f065984f27da63ec48ac3634b551fa6d92f"} 14:48:14 INFO - Running post-run listener: copy_logs_to_upload_dir 14:48:14 INFO - Copying logs to upload dir... 14:48:14 INFO - mkdir: /builds/slave/test/build/upload/logs 14:48:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1327.623374 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-02 14:48:14.182077) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 14:48:14.185472) ========= 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.BXhW7JlwiX/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.mABe2r23KS/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/637abc9f39b7d23bb81f4a9b3d8ec47dd668662cf33be51cc5abd5b91756222c9046202ab4c25e769fd2b31aa94761660bdd4f4169ad68c58bf68fc157208f6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8e73d36392d4a313bee3c058dc25091bba8fb9b0cb81351e09666a5729a44bbddb3cd8cb9bfc68497cb83a22a246a8f8d716b1cc7d9e755faa74ae90af906f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e254ac8b21717f8c056c71fe3ee75a0d792c612c2148235d085e5a94a48896e6181b716c95cad0265bbc512ff7a5f065984f27da63ec48ac3634b551fa6d92f"} build_url:https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011089 build_url: 'https://queue.taskcluster.net/v1/task/FZItwDbYQMO2DIppilHLNQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/637abc9f39b7d23bb81f4a9b3d8ec47dd668662cf33be51cc5abd5b91756222c9046202ab4c25e769fd2b31aa94761660bdd4f4169ad68c58bf68fc157208f6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/8e73d36392d4a313bee3c058dc25091bba8fb9b0cb81351e09666a5729a44bbddb3cd8cb9bfc68497cb83a22a246a8f8d716b1cc7d9e755faa74ae90af906f29", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6e254ac8b21717f8c056c71fe3ee75a0d792c612c2148235d085e5a94a48896e6181b716c95cad0265bbc512ff7a5f065984f27da63ec48ac3634b551fa6d92f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-02 14:48:14.218659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 14:48:14.218975) ========= 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.BXhW7JlwiX/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.mABe2r23KS/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005141 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 14:48:14.268036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 14:48:14.268418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-02 14:48:14.268761) ========= ========= Total master_lag: 0.27 =========