builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0226 starttime: 1468510943.84 results: success (0) buildid: 20160714064843 builduid: e85601e9cfed4acda909725d98bdc68d revision: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:23.839255) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:23.840805) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:23.841121) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:23.865361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:23.865974) ========= 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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-14 08:42:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.48M=0.001s 2016-07-14 08:42:24 (8.48 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146287 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.040147) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.040478) ========= 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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.020900 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.088773) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.089507) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yUCKMwYVAf/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.a7OQnF9XLK/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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-14 08:42:24,174 truncating revision to first 12 chars 2016-07-14 08:42:24,174 Setting DEBUG logging. 2016-07-14 08:42:24,174 attempt 1/10 2016-07-14 08:42:24,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6b9dae7e278d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 08:42:24,573 unpacking tar archive at: fx-team-6b9dae7e278d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.674132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.786312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.786620) ========= script_repo_revision: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.787016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.787282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 08:42:24.805222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-07-14 08:42:24.805511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yUCKMwYVAf/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.a7OQnF9XLK/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:42:24 INFO - MultiFileLogger online at 20160714 08:42:24 in /builds/slave/test 08:42:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:42:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:24 INFO - {'append_to_log': False, 08:42:24 INFO - 'base_work_dir': '/builds/slave/test', 08:42:24 INFO - 'blob_upload_branch': 'Fx-Team', 08:42:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:24 INFO - 'branch': 'Fx-Team', 08:42:24 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:24 INFO - 'config_files': ('talos/mac_config.py',), 08:42:24 INFO - 'default_actions': ('clobber', 08:42:24 INFO - 'read-buildbot-config', 08:42:24 INFO - 'download-and-extract', 08:42:24 INFO - 'populate-webroot', 08:42:24 INFO - 'create-virtualenv', 08:42:24 INFO - 'install', 08:42:24 INFO - 'run-tests'), 08:42:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:24 INFO - 'download_minidump_stackwalk': True, 08:42:24 INFO - 'download_symbols': 'ondemand', 08:42:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:24 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:24 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:24 INFO - 'installer_path': 'installer.exe', 08:42:24 INFO - 'log_level': 'info', 08:42:24 INFO - 'log_name': 'talos', 08:42:24 INFO - 'log_to_console': True, 08:42:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:42:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:42:24 INFO - 'opt_config_files': (), 08:42:24 INFO - 'pip_index': False, 08:42:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:24 INFO - 'cmd': ('bash', 08:42:24 INFO - '-c', 08:42:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:24 INFO - 'enabled': True, 08:42:24 INFO - 'halt_on_failure': False, 08:42:24 INFO - 'name': 'check_screen_resolution'},), 08:42:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:42:24 INFO - 'cmd': ('bash', 08:42:24 INFO - '-c', 08:42:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:42:24 INFO - 'enabled': True, 08:42:24 INFO - 'halt_on_failure': False, 08:42:24 INFO - 'name': 'check_screen_resolution'},), 08:42:24 INFO - 'run_cmd_checks_enabled': True, 08:42:24 INFO - 'sps_profile': False, 08:42:24 INFO - 'sps_profile_interval': 0, 08:42:24 INFO - 'suite': 'dromaeojs-e10s', 08:42:24 INFO - 'system_bits': '32', 08:42:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:24 INFO - 'title': 't-yosemite-r7-0226', 08:42:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:24 INFO - 'use_talos_json': True, 08:42:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:24 INFO - 'work_dir': 'build'} 08:42:24 INFO - ##### 08:42:24 INFO - ##### Running clobber step. 08:42:24 INFO - ##### 08:42:24 INFO - Running pre-action listener: _resource_record_pre_action 08:42:24 INFO - Running main action method: clobber 08:42:24 INFO - rmtree: /builds/slave/test/build 08:42:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:26 INFO - Running post-action listener: _resource_record_post_action 08:42:26 INFO - ##### 08:42:26 INFO - ##### Finished clobber step (success) 08:42:26 INFO - ##### 08:42:26 INFO - ##### 08:42:26 INFO - ##### Running read-buildbot-config step. 08:42:26 INFO - ##### 08:42:26 INFO - Running pre-action listener: _resource_record_pre_action 08:42:26 INFO - Running main action method: read_buildbot_config 08:42:26 INFO - Using buildbot properties: 08:42:26 INFO - { 08:42:26 INFO - "project": "", 08:42:26 INFO - "product": "firefox", 08:42:26 INFO - "script_repo_revision": "production", 08:42:26 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 08:42:26 INFO - "repository": "", 08:42:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 08:42:26 INFO - "buildid": "20160714064843", 08:42:26 INFO - "pgo_build": "False", 08:42:26 INFO - "basedir": "/builds/slave/test", 08:42:26 INFO - "buildnumber": 48, 08:42:26 INFO - "slavename": "t-yosemite-r7-0226", 08:42:26 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 08:42:26 INFO - "platform": "yosemite_r7", 08:42:26 INFO - "scheduler": "tests-fx-team-macosx64-talos", 08:42:26 INFO - "branch": "fx-team", 08:42:26 INFO - "repo_path": "integration/fx-team", 08:42:26 INFO - "revision": "6b9dae7e278dcd38d0b1c221ca9420931dfac7fd", 08:42:26 INFO - "stage_platform": "macosx64", 08:42:26 INFO - "builduid": "e85601e9cfed4acda909725d98bdc68d", 08:42:26 INFO - "slavebuilddir": "test" 08:42:26 INFO - } 08:42:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 08:42:26 INFO - Running post-action listener: _resource_record_post_action 08:42:26 INFO - ##### 08:42:26 INFO - ##### Finished read-buildbot-config step (success) 08:42:26 INFO - ##### 08:42:26 INFO - ##### 08:42:26 INFO - ##### Running download-and-extract step. 08:42:26 INFO - ##### 08:42:26 INFO - Running pre-action listener: _resource_record_pre_action 08:42:26 INFO - Running main action method: download_and_extract 08:42:26 INFO - mkdir: /builds/slave/test/build/tests 08:42:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:42:26 INFO - https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:42:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:42:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:42:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:42:26 INFO - retry: attempt #1 caught exception: '' 08:42:26 INFO - retry: Failed, sleeping 30 seconds before retrying 08:42:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:42:57 INFO - Downloaded 1199 bytes. 08:42:57 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 08:42:57 INFO - Using the following test package requirements: 08:42:57 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:42:57 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 08:42:57 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 08:42:57 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'jsshell-mac.zip'], 08:42:57 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 08:42:57 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 08:42:57 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 08:42:57 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 08:42:57 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 08:42:57 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 08:42:57 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 08:42:57 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:42:57 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')]} 08:42:57 INFO - https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:42:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:42:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:42:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:42:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:42:58 INFO - Downloaded 18827918 bytes. 08:42:58 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'] 08:42:58 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 08:43:01 INFO - Return code: 0 08:43:01 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 08:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:01 INFO - https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:43:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:43:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 08:43:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:43:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:43:02 INFO - Downloaded 18827918 bytes. 08:43:02 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'] 08:43:02 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 08:43:06 INFO - Return code: 0 08:43:06 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')]} 08:43:06 INFO - https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:43:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:43:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 08:43:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:43:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:43:07 INFO - Downloaded 14403317 bytes. 08:43:07 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'] 08:43:07 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 08:43:08 INFO - Return code: 0 08:43: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')]} 08:43:08 INFO - https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 08:43:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:43:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:43:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 08:43:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H6K75C6nTluH1OPiZ6n88A/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 08:43:12 INFO - Downloaded 112741590 bytes. 08:43:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:43:12 INFO - mkdir: /builds/slave/test/properties 08:43:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:43:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:43:12 INFO - Contents: 08:43:12 INFO - build_url:https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 08:43:13 INFO - Running post-action listener: _resource_record_post_action 08:43:13 INFO - Running post-action listener: set_extra_try_arguments 08:43:13 INFO - ##### 08:43:13 INFO - ##### Finished download-and-extract step (success) 08:43:13 INFO - ##### 08:43:13 INFO - ##### 08:43:13 INFO - ##### Running populate-webroot step. 08:43:13 INFO - ##### 08:43:13 INFO - Running pre-action listener: _resource_record_pre_action 08:43:13 INFO - Running main action method: populate_webroot 08:43:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:43:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:43:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:43:13 INFO - '--tppagecycles', 08:43:13 INFO - '7'], 08:43:13 INFO - 'tests': ['tsvgm']}}, 08:43:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:43:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:43:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:43:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:43:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:43:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['damp', 'tps']}, 08:43:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'tests': ['damp', 'tps']}, 08:43:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['dromaeo_dom']}, 08:43:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:43:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['basic_compositor_video']}, 08:43:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:43:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['a11yr', 08:43:13 INFO - 'ts_paint', 08:43:13 INFO - 'tpaint', 08:43:13 INFO - 'sessionrestore', 08:43:13 INFO - 'sessionrestore_no_auto_restore', 08:43:13 INFO - 'tabpaint']}, 08:43:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:43:13 INFO - 'ts_paint', 08:43:13 INFO - 'tpaint', 08:43:13 INFO - 'sessionrestore', 08:43:13 INFO - 'sessionrestore_no_auto_restore', 08:43:13 INFO - 'tabpaint']}, 08:43:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:43:13 INFO - 'ts_paint', 08:43:13 INFO - 'tpaint', 08:43:13 INFO - 'sessionrestore', 08:43:13 INFO - 'sessionrestore_no_auto_restore', 08:43:13 INFO - 'tabpaint']}, 08:43:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:43:13 INFO - 'ts_paint', 08:43:13 INFO - 'tpaint', 08:43:13 INFO - 'sessionrestore', 08:43:13 INFO - 'sessionrestore_no_auto_restore', 08:43:13 INFO - 'tabpaint']}, 08:43:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['a11yr', 08:43:13 INFO - 'ts_paint', 08:43:13 INFO - 'tpaint', 08:43:13 INFO - 'sessionrestore', 08:43:13 INFO - 'sessionrestore_no_auto_restore', 08:43:13 INFO - 'tabpaint']}, 08:43:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['a11yr', 08:43:13 INFO - 'ts_paint', 08:43:13 INFO - 'tpaint', 08:43:13 INFO - 'sessionrestore', 08:43:13 INFO - 'sessionrestore_no_auto_restore', 08:43:13 INFO - 'tabpaint']}, 08:43:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['tsvgx', 08:43:13 INFO - 'tsvgr_opacity', 08:43:13 INFO - 'tart', 08:43:13 INFO - 'tscrollx', 08:43:13 INFO - 'cart']}, 08:43:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:43:13 INFO - 'tsvgr_opacity', 08:43:13 INFO - 'tart', 08:43:13 INFO - 'tscrollx', 08:43:13 INFO - 'cart']}, 08:43:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'talos_options': ['--disable-e10s'], 08:43:13 INFO - 'tests': ['tp5o']}, 08:43:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'tests': ['tp5o']}, 08:43:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'talos_options': ['--disable-e10s', 08:43:13 INFO - '--xperf_path', 08:43:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:13 INFO - 'tests': ['tp5n']}, 08:43:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:43:13 INFO - 'talos_options': ['--xperf_path', 08:43:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:43:13 INFO - 'tests': ['tp5n']}}, 08:43:13 INFO - 'talos.zip': {'path': '', 08:43:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:43:13 INFO - Running post-action listener: _resource_record_post_action 08:43:13 INFO - ##### 08:43:13 INFO - ##### Finished populate-webroot step (success) 08:43:13 INFO - ##### 08:43:13 INFO - ##### 08:43:13 INFO - ##### Running create-virtualenv step. 08:43:13 INFO - ##### 08:43:13 INFO - Running pre-action listener: _resource_record_pre_action 08:43:13 INFO - Running main action method: create_virtualenv 08:43:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:43:13 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 08:43:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:43:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:43:13 INFO - Using real prefix '/tools/python27' 08:43:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:43:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:43:17 INFO - Installing pip.................done. 08:43:17 INFO - Return code: 0 08:43:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:17 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 08:43:17 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 08:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:17 INFO - 'HOME': '/Users/cltbld', 08:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PAGER': '/bin/cat', 08:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:17 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - 'XPC_FLAGS': '0x0', 08:43:17 INFO - 'XPC_SERVICE_NAME': '0', 08:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:17 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 08:43:17 INFO - Cleaning up... 08:43:17 INFO - Return code: 0 08:43:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:43:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 08:43:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:17 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:17 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 08:43:17 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 08:43:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:17 INFO - 'HOME': '/Users/cltbld', 08:43:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:17 INFO - 'LOGNAME': 'cltbld', 08:43:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:17 INFO - 'MOZ_NO_REMOTE': '1', 08:43:17 INFO - 'NO_EM_RESTART': '1', 08:43:17 INFO - 'PAGER': '/bin/cat', 08:43:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:17 INFO - 'PWD': '/builds/slave/test', 08:43:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:17 INFO - 'SHELL': '/bin/bash', 08:43:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:17 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:17 INFO - 'USER': 'cltbld', 08:43:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:17 INFO - 'XPC_FLAGS': '0x0', 08:43:17 INFO - 'XPC_SERVICE_NAME': '0', 08:43:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:18 INFO - Downloading/unpacking psutil>=3.1.1 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:18 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 08:43:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:43:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:21 INFO - Installing collected packages: psutil 08:43:21 INFO - Running setup.py install for psutil 08:43:21 INFO - building 'psutil._psutil_osx' extension 08:43:21 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 08:43:21 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 08:43:21 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 08:43:21 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 08:43:21 INFO - building 'psutil._psutil_posix' extension 08:43:21 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 08:43:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:43:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:43:21 INFO - ^ 08:43:21 INFO - 1 warning generated. 08:43:21 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 08:43:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:43:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:43:21 INFO - Successfully installed psutil 08:43:21 INFO - Cleaning up... 08:43:22 INFO - Return code: 0 08:43:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:22 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:22 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 08:43:22 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 08:43:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:22 INFO - 'HOME': '/Users/cltbld', 08:43:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:22 INFO - 'LOGNAME': 'cltbld', 08:43:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:22 INFO - 'MOZ_NO_REMOTE': '1', 08:43:22 INFO - 'NO_EM_RESTART': '1', 08:43:22 INFO - 'PAGER': '/bin/cat', 08:43:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:22 INFO - 'PWD': '/builds/slave/test', 08:43:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:22 INFO - 'SHELL': '/bin/bash', 08:43:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:22 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:22 INFO - 'USER': 'cltbld', 08:43:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:22 INFO - 'XPC_FLAGS': '0x0', 08:43:22 INFO - 'XPC_SERVICE_NAME': '0', 08:43:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:22 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 08:43:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:43:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:43:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:43:24 INFO - Installing collected packages: mozsystemmonitor 08:43:24 INFO - Running setup.py install for mozsystemmonitor 08:43:24 INFO - Successfully installed mozsystemmonitor 08:43:24 INFO - Cleaning up... 08:43:25 INFO - Return code: 0 08:43:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:43:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:43:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:25 INFO - 'HOME': '/Users/cltbld', 08:43:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:25 INFO - 'LOGNAME': 'cltbld', 08:43:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:25 INFO - 'MOZ_NO_REMOTE': '1', 08:43:25 INFO - 'NO_EM_RESTART': '1', 08:43:25 INFO - 'PAGER': '/bin/cat', 08:43:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:25 INFO - 'PWD': '/builds/slave/test', 08:43:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:25 INFO - 'SHELL': '/bin/bash', 08:43:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:25 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:25 INFO - 'USER': 'cltbld', 08:43:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:25 INFO - 'XPC_FLAGS': '0x0', 08:43:25 INFO - 'XPC_SERVICE_NAME': '0', 08:43:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:25 INFO - Downloading/unpacking jsonschema==2.5.1 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:43:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:28 INFO - Downloading functools32-3.2.3-2.tar.gz 08:43:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:43:28 INFO - warning: no files found matching '*.txt' 08:43:28 INFO - no previously-included directories found matching 'build' 08:43:28 INFO - no previously-included directories found matching 'dist' 08:43:28 INFO - no previously-included directories found matching '.git*' 08:43:28 INFO - Installing collected packages: jsonschema, functools32 08:43:28 INFO - Running setup.py install for functools32 08:43:28 INFO - warning: no files found matching '*.txt' 08:43:28 INFO - no previously-included directories found matching 'build' 08:43:28 INFO - no previously-included directories found matching 'dist' 08:43:28 INFO - no previously-included directories found matching '.git*' 08:43:28 INFO - Successfully installed jsonschema functools32 08:43:28 INFO - Cleaning up... 08:43:28 INFO - Return code: 0 08:43:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:43:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:43:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:43:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:28 INFO - 'HOME': '/Users/cltbld', 08:43:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:28 INFO - 'LOGNAME': 'cltbld', 08:43:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:28 INFO - 'MOZ_NO_REMOTE': '1', 08:43:28 INFO - 'NO_EM_RESTART': '1', 08:43:28 INFO - 'PAGER': '/bin/cat', 08:43:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:28 INFO - 'PWD': '/builds/slave/test', 08:43:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:28 INFO - 'SHELL': '/bin/bash', 08:43:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:28 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:28 INFO - 'USER': 'cltbld', 08:43:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:28 INFO - 'XPC_FLAGS': '0x0', 08:43:28 INFO - 'XPC_SERVICE_NAME': '0', 08:43:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:29 INFO - Downloading/unpacking blobuploader==1.2.4 08:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:31 INFO - Downloading blobuploader-1.2.4.tar.gz 08:43:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:43:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:43:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:43:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:43:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:43:32 INFO - Downloading docopt-0.6.1.tar.gz 08:43:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:43:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:43:33 INFO - Running setup.py install for blobuploader 08:43:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:43:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:43:33 INFO - Running setup.py install for requests 08:43:33 INFO - Running setup.py install for docopt 08:43:33 INFO - Successfully installed blobuploader requests docopt 08:43:33 INFO - Cleaning up... 08:43:33 INFO - Return code: 0 08:43:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:33 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')]} 08:43:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:33 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')]} 08:43:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:33 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:33 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 08:43:33 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 08:43:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:33 INFO - 'HOME': '/Users/cltbld', 08:43:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:33 INFO - 'LOGNAME': 'cltbld', 08:43:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:33 INFO - 'MOZ_NO_REMOTE': '1', 08:43:33 INFO - 'NO_EM_RESTART': '1', 08:43:33 INFO - 'PAGER': '/bin/cat', 08:43:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:33 INFO - 'PWD': '/builds/slave/test', 08:43:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:33 INFO - 'SHELL': '/bin/bash', 08:43:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:33 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:33 INFO - 'USER': 'cltbld', 08:43:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:33 INFO - 'XPC_FLAGS': '0x0', 08:43:33 INFO - 'XPC_SERVICE_NAME': '0', 08:43:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-zBWuTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-8o209U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-MiucQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ChFK4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-LZDmyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-nNB76j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-rhVaXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-YCbGYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:34 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-yDs6ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-jiVErj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-F1n0nZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-BQsJxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-HyNMWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-23xNDk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-JGPIxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-OBwwV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:35 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-9Y3ZqY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:43:35 INFO - Running setup.py install for manifestparser 08:43:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:43:36 INFO - Running setup.py install for mozcrash 08:43:36 INFO - Running setup.py install for mozdebug 08:43:36 INFO - Running setup.py install for mozdevice 08:43:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:43:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:43:36 INFO - Running setup.py install for mozfile 08:43:36 INFO - Running setup.py install for mozhttpd 08:43:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:43:36 INFO - Running setup.py install for mozinfo 08:43:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:43:36 INFO - Running setup.py install for mozInstall 08:43:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Running setup.py install for mozleak 08:43:37 INFO - Running setup.py install for mozlog 08:43:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Running setup.py install for moznetwork 08:43:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Running setup.py install for mozprocess 08:43:37 INFO - Running setup.py install for mozprofile 08:43:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:43:37 INFO - Running setup.py install for mozrunner 08:43:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:43:38 INFO - Running setup.py install for mozscreenshot 08:43:38 INFO - Running setup.py install for moztest 08:43:38 INFO - Running setup.py install for mozversion 08:43:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:43:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:43:38 INFO - Cleaning up... 08:43:38 INFO - Return code: 0 08:43:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43: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')]} 08:43:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43: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')]} 08:43:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:38 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:38 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 08:43:38 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 08:43:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:38 INFO - 'HOME': '/Users/cltbld', 08:43:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:38 INFO - 'LOGNAME': 'cltbld', 08:43:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:38 INFO - 'MOZ_NO_REMOTE': '1', 08:43:38 INFO - 'NO_EM_RESTART': '1', 08:43:38 INFO - 'PAGER': '/bin/cat', 08:43:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:38 INFO - 'PWD': '/builds/slave/test', 08:43:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:38 INFO - 'SHELL': '/bin/bash', 08:43:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:38 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:38 INFO - 'USER': 'cltbld', 08:43:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:38 INFO - 'XPC_FLAGS': '0x0', 08:43:38 INFO - 'XPC_SERVICE_NAME': '0', 08:43:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:43:38 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-ifqie_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:43:38 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)) 08:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:43:38 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-kOfpvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:43:38 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)) 08:43:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:43:38 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-PvFEFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-AlagzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-V4mA_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-uagvFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-YCtf_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-OkAifL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-S_8U8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-NAyeKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-O9ZAxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:43:39 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)) 08:43:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:43:39 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-yc1y54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:43:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-W0XxXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:43:40 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)) 08:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:43:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-G0puxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:43:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-dnpeL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:43:40 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)) 08:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:43:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-Xp95XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:43:40 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)) 08:43:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:43:40 INFO - Running setup.py (path:/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/pip-6cE1Xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:43:40 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)) 08:43:40 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)) 08:43:40 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)) 08:43:40 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)) 08:43:40 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)) 08:43:40 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)) 08:43:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43: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 08:43:43 INFO - Downloading blessings-1.6.tar.gz 08:43:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:43:43 INFO - Installing collected packages: blessings 08:43:43 INFO - Running setup.py install for blessings 08:43:43 INFO - Successfully installed blessings 08:43:43 INFO - Cleaning up... 08:43:43 INFO - Return code: 0 08:43:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:43:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:43 INFO - Reading from file tmpfile_stdout 08:43:43 INFO - Current package versions: 08:43:43 INFO - blessings == 1.6 08:43:43 INFO - blobuploader == 1.2.4 08:43:43 INFO - docopt == 0.6.1 08:43:43 INFO - functools32 == 3.2.3-2 08:43:43 INFO - jsonschema == 2.5.1 08:43:43 INFO - manifestparser == 1.1 08:43:43 INFO - mozInstall == 1.12 08:43:43 INFO - mozcrash == 0.17 08:43:43 INFO - mozdebug == 0.1 08:43:43 INFO - mozdevice == 0.48 08:43:43 INFO - mozfile == 1.2 08:43:43 INFO - mozhttpd == 0.7 08:43:43 INFO - mozinfo == 0.9 08:43:43 INFO - mozleak == 0.1 08:43:43 INFO - mozlog == 3.2 08:43:43 INFO - moznetwork == 0.27 08:43:43 INFO - mozprocess == 0.23 08:43:43 INFO - mozprofile == 0.28 08:43:43 INFO - mozrunner == 6.12 08:43:43 INFO - mozscreenshot == 0.1 08:43:43 INFO - mozsystemmonitor == 0.3 08:43:43 INFO - moztest == 0.7 08:43:43 INFO - mozversion == 1.4 08:43:43 INFO - psutil == 3.1.1 08:43:43 INFO - requests == 1.2.3 08:43:43 INFO - wsgiref == 0.1.2 08:43:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:43:43 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')]} 08:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:43 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')]} 08:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:43 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:43 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 08:43:43 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 08:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:43 INFO - 'HOME': '/Users/cltbld', 08:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:43 INFO - 'LOGNAME': 'cltbld', 08:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:43 INFO - 'MOZ_NO_REMOTE': '1', 08:43:43 INFO - 'NO_EM_RESTART': '1', 08:43:43 INFO - 'PAGER': '/bin/cat', 08:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:43 INFO - 'PWD': '/builds/slave/test', 08:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:43 INFO - 'SHELL': '/bin/bash', 08:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:43 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:43 INFO - 'USER': 'cltbld', 08:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:43 INFO - 'XPC_FLAGS': '0x0', 08:43:43 INFO - 'XPC_SERVICE_NAME': '0', 08:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 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)) 08:43:43 INFO - Cleaning up... 08:43:43 INFO - Return code: 0 08:43:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:43:43 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')]} 08:43:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:43:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:43 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')]} 08:43:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:43:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:43:43 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 0x10c2bda30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c352618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f841846b7f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, '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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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 08:43:43 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 08:43:43 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 08:43:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:43:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:43:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:43:43 INFO - 'HOME': '/Users/cltbld', 08:43:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:43:43 INFO - 'LOGNAME': 'cltbld', 08:43:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:43 INFO - 'MOZ_NO_REMOTE': '1', 08:43:43 INFO - 'NO_EM_RESTART': '1', 08:43:43 INFO - 'PAGER': '/bin/cat', 08:43:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:43:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:43 INFO - 'PWD': '/builds/slave/test', 08:43:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:43:43 INFO - 'SHELL': '/bin/bash', 08:43:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:43:43 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:43:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:43:43 INFO - 'USER': 'cltbld', 08:43:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:43:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:43:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:43 INFO - 'XPC_FLAGS': '0x0', 08:43:43 INFO - 'XPC_SERVICE_NAME': '0', 08:43:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:43:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:43:44 INFO - Cleaning up... 08:43:44 INFO - Return code: 0 08:43:44 INFO - Running post-action listener: _resource_record_post_action 08:43:44 INFO - Running post-action listener: _start_resource_monitoring 08:43:44 INFO - Starting resource monitoring. 08:43:44 INFO - ##### 08:43:44 INFO - ##### Finished create-virtualenv step (success) 08:43:44 INFO - ##### 08:43:44 INFO - ##### 08:43:44 INFO - ##### Running install step. 08:43:44 INFO - ##### 08:43:44 INFO - Running pre-action listener: _resource_record_pre_action 08:43:44 INFO - Running main action method: install 08:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:43:44 INFO - Reading from file tmpfile_stdout 08:43:44 INFO - Detecting whether we're running mozinstall >=1.0... 08:43:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:43:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:43:44 INFO - Reading from file tmpfile_stdout 08:43:44 INFO - Output received: 08:43:44 INFO - Usage: mozinstall [options] installer 08:43:44 INFO - Options: 08:43:44 INFO - -h, --help show this help message and exit 08:43:44 INFO - -d DEST, --destination=DEST 08:43:44 INFO - Directory to install application into. [default: 08:43:44 INFO - "/builds/slave/test"] 08:43:44 INFO - --app=APP Application being installed. [default: firefox] 08:43:44 INFO - mkdir: /builds/slave/test/build/application 08:43:44 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'] 08:43:44 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 08:44:18 INFO - Reading from file tmpfile_stdout 08:44:18 INFO - Output received: 08:44:18 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:44:18 INFO - Running post-action listener: _resource_record_post_action 08:44:18 INFO - ##### 08:44:18 INFO - ##### Finished install step (success) 08:44:18 INFO - ##### 08:44:18 INFO - ##### 08:44:18 INFO - ##### Running run-tests step. 08:44:18 INFO - ##### 08:44:18 INFO - Running pre-action listener: _resource_record_pre_action 08:44:18 INFO - Running main action method: run_tests 08:44:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:44:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:44:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:44:18 INFO - 2016-07-14 08:44:18.998 screenresolution[2208:21903] starting screenresolution argv=screenresolution get 08:44:19 INFO - 2016-07-14 08:44:19.001 screenresolution[2208:21903] Display 0: 1600x1200x32@60 08:44:19 INFO - 2016-07-14 08:44:19.007 screenresolution[2209:21907] starting screenresolution argv=screenresolution list 08:44:19 INFO - Available Modes on Display 0 08:44:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:44:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:44:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:44:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:44:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:44:19 INFO - Intel Iris: 08:44:19 INFO - Chipset Model: Intel Iris 08:44:19 INFO - Type: GPU 08:44:19 INFO - Bus: Built-In 08:44:19 INFO - VRAM (Dynamic, Max): 1536 MB 08:44:19 INFO - Vendor: Intel (0x8086) 08:44:19 INFO - Device ID: 0x0a2e 08:44:19 INFO - Revision ID: 0x0009 08:44:19 INFO - Displays: 08:44:19 INFO - Display: 08:44:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:44:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:44:19 INFO - Display Serial Number: 1600x1200 60 08:44:19 INFO - Main Display: Yes 08:44:19 INFO - Mirror: Off 08:44:19 INFO - Online: Yes 08:44:19 INFO - Rotation: Supported 08:44:19 INFO - Return code: 0 08:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:44:19 INFO - Python 2.7.3 08:44:19 INFO - Return code: 0 08:44:19 INFO - grabbing minidump binary from tooltool 08:44:19 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')]} 08:44:19 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 0x10c221d30>, '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 0x10bf86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c219b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:44:19 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 08:44:19 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 08:44:19 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 08:44:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:44:19 INFO - Return code: 0 08:44:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:44:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:44:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:44:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:44:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:44:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:44:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0226 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:44:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yUCKMwYVAf/Render', 08:44:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:44:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:44:19 INFO - 'HOME': '/Users/cltbld', 08:44:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:44:19 INFO - 'LOGNAME': 'cltbld', 08:44:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:44:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:44:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:44:19 INFO - 'MOZ_NO_REMOTE': '1', 08:44:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:44:19 INFO - 'NO_EM_RESTART': '1', 08:44:19 INFO - 'PAGER': '/bin/cat', 08:44:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:44:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:44:19 INFO - 'PWD': '/builds/slave/test', 08:44:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:44:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:44:19 INFO - 'SHELL': '/bin/bash', 08:44:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.a7OQnF9XLK/Listeners', 08:44:19 INFO - 'TMPDIR': '/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/', 08:44:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:44:19 INFO - 'USER': 'cltbld', 08:44:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:44:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:44:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:44:19 INFO - 'XPC_FLAGS': '0x0', 08:44:19 INFO - 'XPC_SERVICE_NAME': '0', 08:44:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:44:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0226', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:44:19 INFO - mozversion application_buildid: 20160714064843 08:44:19 INFO - mozversion application_changeset: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd 08:44:19 INFO - mozversion application_display_name: Nightly 08:44:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:44:19 INFO - mozversion application_name: Firefox 08:44:19 INFO - mozversion application_remotingname: firefox 08:44:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:44:19 INFO - mozversion application_vendor: Mozilla 08:44:19 INFO - mozversion application_version: 50.0a1 08:44:19 INFO - mozversion platform_buildid: 20160714064843 08:44:19 INFO - mozversion platform_changeset: 6b9dae7e278dcd38d0b1c221ca9420931dfac7fd 08:44:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:44:19 INFO - mozversion platform_version: 50.0a1 08:44:19 INFO - using testdate: 1468511059 08:44:19 INFO - actual date: 1468511059 08:44:19 INFO - starting webserver on 'localhost:53253' 08:44:19 INFO - SUITE-START | Running 2 tests 08:44:19 INFO - TEST-START | dromaeo_css 08:44:19 INFO - operating with platform_type : mac_ 08:44:19 INFO - Initialising browser for dromaeo_css test... 08:44:19 INFO - TEST-INFO | started process 2219 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpJICq5g/profile http://localhost:53253/getInfo.html) 08:44:22 INFO - PROCESS | 2219 | __metrics Screen width/height:1600/1200 08:44:22 INFO - PROCESS | 2219 | colorDepth:24 08:44:22 INFO - PROCESS | 2219 | Browser inner width/height: 1024/689 08:44:22 INFO - PROCESS | 2219 | __metrics 08:44:22 ERROR - PROCESS | 2219 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 08:44:23 INFO - TEST-INFO | 2219: exit 0 08:44:23 INFO - Browser initialized. 08:44:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:44:23 INFO - TEST-INFO | started process 2222 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpJICq5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:44:35 INFO - PROCESS | 2222 | RSS: Main: 254128128 08:44:35 INFO - PROCESS | 2222 | 08:45:25 INFO - PROCESS | 2222 | 1468511125234 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] 08:47:36 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53253/tests/dromaeo/cssquery-ext.html) 08:47:38 INFO - PROCESS | 2222 | RSS: Main: 266518528 08:47:38 INFO - PROCESS | 2222 | 08:50:40 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-ext.html (next: http://localhost:53253/tests/dromaeo/cssquery-jquery.html) 08:50:41 INFO - PROCESS | 2222 | RSS: Main: 275062784 08:50:41 INFO - PROCESS | 2222 | 08:53:42 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53253/tests/dromaeo/cssquery-mootools.html) 08:53:43 INFO - PROCESS | 2222 | RSS: Main: 279629824 08:53:43 INFO - PROCESS | 2222 | 08:56:45 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53253/tests/dromaeo/cssquery-prototype.html) 08:56:45 INFO - PROCESS | 2222 | RSS: Main: 278585344 08:56:45 INFO - PROCESS | 2222 | 08:59:48 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53253/tests/dromaeo/cssquery-yui.html) 08:59:49 INFO - PROCESS | 2222 | RSS: Main: 282238976 08:59:49 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | Cycle 1(1): loaded http://localhost:53253/tests/dromaeo/cssquery-yui.html (next: http://localhost:53253/tests/dromaeo/cssquery-dojo.html) 09:02:52 INFO - PROCESS | 2222 | RSS: Main: 282607616 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | __start_tp_report 09:02:52 INFO - PROCESS | 2222 | _x_x_mozilla_page_load 09:02:52 INFO - PROCESS | 2222 | _x_x_mozilla_page_load_details 09:02:52 INFO - PROCESS | 2222 | |i|pagename|runs| 09:02:52 INFO - PROCESS | 2222 | |0;dojo.html;3339.5825521809775;3342.348242092792;3381.45896656535;3387.3733359328526;3395.1172695099267;4892.6330525210615;5752.424757524245;5802.738876750545;5857.297124345074;5871.119332100187;4744.833930812422;5655.095184770437;5793.015187418138;5852;5871.588988770788;4252.2345977724;4560.521145279731;4917.704937703731;5357.4374690657505;5426.321709786277;5182.922256166161;5372.409035006146;5402.459754024605;5425.159100339453;5429.239906413105;5257.921131182997;5284;5296.285001524783;5297.920531192035;5339.679619222859;5291.629585928987;5294.814681486168;5295.841124766263;5316.175992721134;5316.229146773735;5265.104932161542;5271.20931860224;5287.920681189786;5303.363596368422;5337.653052551572;4807.927881081787;5633.464820842013;5742.856428589319;5796.449337312949;5851.180834683148;6222.540307349775;6258;6261.530385221126;6282.120503129519;6290.119383286344;6119.204503414572;6120.142398366908;6223.222097237845;6235.407636274592;6246.469050130744;4798.47216806151;5747.770089196469;5811.331696854873;5912.438318359749;5925.82222533329;4636.281376386598;5378.1663842104535;6305.747770089237;6306.243250809932;6326.873462530723;6109.663968481687;6113.172264937315;6224.221972253468;6249.6562689052535;6255.468285195719;6179.227596550431;6259.561830671809;6297.4647154992335;6297.559170857996;6337.397947195009;6108.389161083945;6166.4758495527485;6173.506119510428;6253.499720022387;6255.311915689271;6104.489471593149;6159.4456498914415;6198.752049918043;6321.1150438938585;6338.651374174465;4898.314236006961;4940.283658869444;4941.703497790144;4951.90096198074;5003.024410240041;4437.356583295404;4441.622462090694;4454.309582014793;4457.442819647544;4513.187626227311;5738.598298119092;5902.8819423611285;5930.733117009745;5941.792037278675;6028.577999540078;6256.436920677161;6265.71804268809;6268.717907694165;6268.780592679234;6278.434940855345;5901.144334071536;5997.017892644135;6002.789902353396;6020.367861374492;6052.12244224585;5310.911263191037;5409.5131438169965;5437.48343907336;5444;5464.754086066137;6311.6096689333035;6333.714982825784;6342.873142537216;6353.618782873043;6418.069379939882;6255;6262.279837818527;6268.059791031382;6271.278802937721;6278.0896769967185;4769.73766442849;6136.365905528456;6179.907301390573;6222.595531290452;6228.501719862491;5239.816606418757;6028.668423236764;6081.787137450168;6255.936490796485;6280.874382512233;6154.599951003171;6225.968870155621;6267.5299352549655;6289;6312.242530896322;5966.254218222723;5975.223220981418;6116.366205733216;6125.816225513242;6152.907706384318;6144.218176728878;6153.6000159991245;6233.0338797486465;6234.064890266496;6240;4613.308003799457;5945.078512830518;6010.699465026819;6057.575969682256;6084.452399284086;6015.2781666200335;6105.399096011559;6136.764169924414;6145.631262124287;6206.06908963659;4919.655624106278;5996.910046349395;6044.884409724384;6065.150878877049;6100.298465676504 09:02:52 INFO - PROCESS | 2222 | |1;ext.html;434.5806296923468;459.8091791906359;519.6855902179182;547.9232907392966;561.121844313649;30737.385252294967;40530.59469405305;40570.59429405709;40610.390844137364;40615.79692101535;33926.66073339272;41466;41498.58501414985;41916.371254431135;41951.16097678045;8081.919180808205;9508.80982380352;9645.951770241174;9698.981606931276;9754.512274386288;8070.757877263692;9564.617415303379;9618.326717129803;9660.372075815085;9665.5167241638;9618.422894626345;9620.326577139604;9682.12860842524;9682.177014953737;9702.320837541374;9588.089131532493;9595.088466595627;9626.422414655108;9643.951780241125;9644.662436814679;9478.289128315404;9495.810083798286;9563.426194428357;9573.617055317778;9581.520923953774;39681;39721.40417893705;39841.203175936316;40003.39994900079;40070;2996.895108671186;3395.8079405358885;3514.191735900757;3525.065857547752;3666.651668091527;30624.693753062405;31694.683053169636;32532.6746732532;32619.51070733941;32667;3245.383377158332;3390.135515443571;3399.6260411354733;3436.2096717755057;3436.3127374525193;495192;501527;506653;507609.9239007637;507649.99999999633;33448.49827252593;62166.71582915413;62255;62857.37142628607;62895.05657415142;34049.82975085109;34129.658703413144;34697.959061228205;34798.82600586981;34826.82586587051;14463.204523751294;14678.339474723663;14708.779368309484;14720.484783032756;14739.263036848115;12460.937695311466;12518.561850335194;12540.749185016248;12571.245725256515;12667.606563278032;6791.4906382021545;7344.96327518359;7588.089429268523;7637.19809420014;7677.654505547152;2851.6578010638855;3238.9149634872583;3242.4325742994884;3246.740260779132;3258.1040213940882;765.9004329437138;828.995855020721;997.4464172384396;1061.9575216991389;1071.8499410082595;30230.84884575563;30357.392852142835;30581.69418305833;31079.84460077685;31779.364412711617;849.7365816596874;1039.3296323871061;1114.7324642086003;1147.9196456247982;1194.4863708605383;12969.675758105934;14404;15313.310901009481;15894.785629207996;15959.601009974844;685247;702675;704570;705472;707086;58000;58830.7058464705;58944.705276473345;59485.702571486865;59496.70251648714;1247.5072346423112;1359.6804750883534;1383.1700979412474;1446.305773228856;1448.876845468147;29140;29987.100386988426;30210.9426170083;30586.541201881544;31989.04032879017;57162.7141864288;57204.42795571991;58107.547311315866;58130.83738325125;58228.4177158223;614060;621750;622025;622405;624478;37796;42546.361804572334;44290.3356449647;44850;44906.55093449024;48700.5129948696;49004;49246.75376623094;50351.24473132979;50372.49627503678;40332.798336008134;40467.595324046386;41458;41612.58387416087;42016.369754453095;39327.80336098416;40317.59682403138;40551.797241013606;40979.795101024305;41112.38331424971;33549;38816;38868.61131388763;38936.61063389443;39710.40434393544;34606.480902785974;35130.47304290387;35671.92984210478;36021.45967810538;36244;25769.355766105997;25987;26014.34964125912;26125.08562200314;26454.338641534116 09:02:52 INFO - PROCESS | 2222 | |2;jquery.html;323.4339905165958;358.65031594195653;381.8129116732801;391.97060220483473;401.4079233131132;15881.205939703012;16933;21052.57894842104;21625.81058041807;21993.340199794013;20921.581568368623;21443.035063422143;21484.89257553714;21522.246721364754;21756.782432175674;4727.385439892809;5860.619059761112;6018.127371531147;6026.126211699301;6053.969730151343;5946.464818166364;5964;5987.461128498434;5997.640141591497;6009.248843894513;5125.974805038988;5535.750891209906;5746.655200687951;5926.081457374114;5936.673482958436;5842.328132264759;5881.411858814127;5911.6748578828365;5912.911306330387;5939.109133629947;5047.066292735819;5122.564582010534;5147.562457191143;5150.175971844525;5155.278261043457;23900.40248993772;25727.970881164732;26091.73908260912;26496;26597.335066623295;2146.066461089431;2193.1775584155944;2276.612975794119;2277.1587743732657;2401.3876461502205;10531.894681053169;10629.20280978922;10703.946480267627;11691.766164676745;16025.35898564056;1862;1959.8138176873174;1970.9704354434696;1979.5150188203982;1985.9007049647605;106840;115310.42344788306;120159.39920300343;128776;130431.34784326113;11516.251443656136;11700.473478693479;11830.645080647595;11841.407929603485;11942.582009629621;14618.488352907598;14641;14816.555503334917;14822.258887055605;14863.925680371745;8656.567171641393;8725.127487251224;8726.432781869158;8865.867011994826;8898.644054237888;8660.30717542595;8718;8728.912710872937;8799.604017819214;8870.423422477648;4068.572799856032;4183.979080104641;4622.560856718674;4689.554492323224;4696.671233013724;1912.311567835578;1972.9148968067504;2029.5737895041912;2031.4718173275055;2031.9796802032085;722.4653756220359;784.1022029775875;882.245679943639;898.1512470715112;976.6337623391229;21543;21945.67081493779;21949;22070.88964555199;22404;967.5259123029665;1008.1732978957331;1012.4785735346303;1066.5520481397832;1101.218135124055;9730.95134524323;11178.888211117948;11538.88461115395;11651.067914566815;11652.41737913101;598061;611238.9438052782;615717;625671.8716406389;626888;62387.68806156031;95581.52209238909;109260;128137;133302.66697333095;824.7031068815222;936.2697096264924;970.7864269860619;972.863799068131;1056.5984925728328;15678.529644110695;19818.801811981695;20092.89953550223;20295.4926126848;20368.490787730425;39085;51005;57516.84966300734;59455.405445946715;60105.69947150236;71329.57340853258;86356.27287454341;88029.55985220033;88766;88901;8129.9187008129165;8349.457285276438;8433.789155271168;8499.660013599387;8512.276456501268;11207.71980700489;12319.199252048587;13238;13252.138610990254;13314.800277995644;7140.5358651687475;9690.467024313448;9794.314397992071;11138.832917506083;11281.661550153509;11223.214374993671;11331.376774277494;11367.715807104889;11457.312561246352;11521.942390287995;11741.941290293495;11762;11769;11805.645830625095;11879.406029698308;6036.8188954331445;7571.977782999445;7658.081030276179;7676.808079797826;8581.8712719308;8402.159784021549;11002.944985275022;11673.299602023906;11682.532698692297;11763.470643820878 09:02:52 INFO - PROCESS | 2222 | |3;mootools.html;1561.7423125184343;1567.3260497985868;1824.8083951185126;1901.8763780354277;1920.1839218332204;8098.06872209696;8733.606987685553;8789.165029322212;9257.213136883365;9285.303602229826;7669.884951725729;8798.604062817172;8848.646054157842;9021.909780902206;9049.864252036225;2344.601417758981;2372.406898275431;2383.0467812874904;2386.59427897257;2388.319328991238;2341.8711970841596;2363.0783994242174;2401.711794584652;2404.843685160459;2414.806815454768;2372.6085195942737;2384.7376788553247;2387.212219967407;2391.1391898916377;2398.352444839892;1969.6257711034857;2347.4835536182013;2365.254944692425;2372.489914668346;2378.2865140457966;2351.4245455544656;2361.7165940087298;2361.881905904715;2364.243442098529;2366.727826299963;8092.514449133071;8543.700970466003;9033.728988130366;9048.864267036;9103.544822758835;5246.842594722164;5384.380796208447;5410.323709536308;5413.485718856702;5422.15956526739;3622.239329740731;3652.7808331500196;3717.5538935327663;3722.181120153562;3726.329260733067;1091.6288461922904;1092.918031147667;1098.203802243375;1102.1898904305328;1122.2032357026521;11753.764924701458;11984.760304793943;11994.16040877139;11995.280283183038;12002.099842511847;4633.142868569325;4641.74470404131;4844.660873738875;4863.781129849165;4864.902701945941;10167.389956602627;10212.897871021194;10247.487625618689;10259.58961641541;10264.589416423409;5295.364556253197;5374.11327131019;5408.648437851527;5410.83767486976;5426.104692725735;4418.9337159942625;4795.400574928134;4955.207166853358;4958.305837182797;4959.008198360342;4061.3429966417757;4085.5914408558906;4122.525909520384;4132.442120313719;4135.1316223592785;1310.724747802953;1321.7422602592594;1323.6558494791423;1336.5789776220458;1340.5710172744627;945.9621615135318;949.9335046546676;979.6620166042704;994.6121012805012;1007.8253501470426;6175.69121543921;6250;6278.6860656966965;6305.306416294204;6365.777197798055;443.2464809823313;455.07619532349383;460.9723416595015;461.8452818305838;468.04051694027106;4237.957620423818;4249.575042495788;4274.786260686953;4297.333913243452;4314.482262128502;10663.146948244123;11168.274062185932;11205.271657342246;11210.383428911487;11213.934676205747;10250;10897.455127243606;11033.944830275957;11147.498362573704;11159.386233757059;8134.715284965117;8291.419600627898;8399.034111077304;8451.746447606582;8477;5019.949800502094;6120.234970628671;6331.841703957438;6352.36476352361;6511.055896895018;10140.847887281845;10258.17934565248;10299.3820370778;10375.990962621057;10476.842847357448;10396.324238924446;10522.631707890187;10540.15678745714;10541.894581054092;10596.841047384141;6937.930620693728;7634.961825190839;7732.304092631465;7742.961285193538;7778.766637000899;8582.742517724479;8713.346499012472;8715.128487151234;8782.473051616924;8785.560721963748;7688.308052275322;7826.491278067135;7867.84264314722;7927.088384835587;7960.442769006114;7580.696772129053;7698.34564062061;7699.3840492761565;7806.92193078062;7815.25755053269;6388.1376014237485;6460.515461340325;7080.539764915264;7096;7325.4505912057875;5039.647224694236;5150.918307155539;5228.895422091461;5288.735563221747;5324.8136315228785;5233.162693968947;5241.554467870274;5270.947290527046;5330.200469929541;5356.143576624824 09:02:52 INFO - PROCESS | 2222 | |4;prototype.html;300.8807237078069;302.70637481642797;305.70957590289225;318.1410192480301;318.3585076071716;4336.8290561548365;4635.238609328455;5490.588205884565;5638.887222255553;5689.146628005801;4493;5645.5483561315095;5655.321361436623;5664.037113690672;5679.659220446766;3531.364354416204;4236.788160591974;4252.89367765806;4260.636596289189;4274.572542745716;4121.340585506319;4279.315309550472;4279.486461624594;4289;4315.352697095429;3476.4263896457055;3690.870819521317;4050.926504476316;4193.622573968342;4275.380069889864;3937.310970580151;4098.7540747555095;4172.874813755592;4271.466066741657;4279.293916503773;3271.525628783813;3691.2248427830186;3691.7969511676847;3698.31581157484;3699.26014797039;4210.599958023928;5255.684658920439;5327.801244719945;5438.53772429344;5515.255440515519;4275.593818587229;4847.054824309226;4865.44047434546;4885.780139893714;4916.041371932474;5216.478352164791;5670.914936275959;6013.609115407485;6028.668423236721;6034.788782392595;3547.9822600887087;4014.2974979378782;4022.8591999279884;4038.7778672173017;4047.8583249586122;5503.834884953458;5605.131204663284;6031.431827724823;6312.685839934025;6331.588446750947;3610.7833529988284;3718.7768733876055;3810.733248672622;4126.463559737275;4136.21411931732;3640.4903313536124;3832.176082142297;3922.5685174630767;4115.156392939441;4155.625993660585;4247;4881.341018962395;4881.389826271716;4888;4935.75321233944;5268.81559145428;5676.659400435905;5940.495057920039;6024.759009639653;6024.849378765478;1385.6951470676436;1420.921849298278;1428.1502506008908;1432.0977783996225;1432.3124900048035;848.9278411334982;869.1091631078069;876.9517676527724;883.571467838098;885.5439448683933;4352.410315862057;4528.5961351981;4662.368171140074;4692.747481209039;4757.976210118927;4575.9084818303445;5131.281620573122;5144.794208231704;5180.513353590298;5187.351581052369;4483.775811209492;4690.241159565163;4711.316859055418;4720.905581888412;4765.448996208613;2237.876916769593;2611.686597608299;2620.187741800048;2720.326998895665;2739.7260273972843;4818.68678535894;4990.850274491771;5071.323290614275;5378.489043540857;5380.677159370451;4869.784248167076;4958.975205123951;5318.813841515528;5357.517823395913;5407.756650950717;4300.956990430118;4754.524547545356;4886.291487734258;5354;5387.542058925035;4792.161371759998;4970.701757894538;5190.624484511683;5210.843674689614;5233.801803242571;4425.668074894332;4594.058218065222;4967.7516124192925;5449.901787811642;6170.969145154246;5636.154576813511;6381.617102973836;6409.8718025640155;6420.55056146084;6438.517111216771;3367.343368043306;3792.8672496463596;4069.1861627673993;4091.40674602187;4094.0174358154422;5820.563457740602;5925.585209035498;6022.698865056817;6199.752009919733;6237.75048998035;4996.250562415521;5145.511176438233;5660.754633980518;6044.304904935812;6053.75784968614;5066.885285237242;5938.317093534299;6000.969995149996;6061.272647282354;6074.848128796815;5671.723862130987;5818.796342128006;5853.385394533512;5868.706564671664;5876.529877609866;5421.566274697936;5483.314585676791;5649.4350564944825;5680.6591604503865;6011.248593925759;5125.513076257749;5531.612787104864;5593.720313984366;5870.679097203095;5882.794102206402 09:02:52 INFO - PROCESS | 2222 | |5;yui.html;631.8451979265079;717.9138503379592;794.5987276425404;796.7092011415835;827.2761333832894;15446.99594526355;16130.435434759785;16295.103769292684;16302.51092467225;16350.918245408771;12363.072769542297;14013.92993035036;14707.264636768172;14777.113373197615;14790.926045369784;897.0536084430922;917.092078841945;919.6367434863225;919.9724008279729;922.8523436250201;718.881384571545;885.1679421343916;919.9448033118001;923.1691477670117;923.3582660051267;956.1920177450044;969.9078587534173;969.9321047526676;972.8394814855541;974.28390133252;941.9858702119474;963.0610155098793;965.4255717847869;966.0677446264353;966.5215718219491;689.4002218070261;711.7580022792224;713.9714411423537;717.5049216040967;717.6626985316892;12627.989760819113;15122.621934451727;15450.0729956203;15458.227088645523;15585.922070389688;14698.926505367404;14755.852441475556;14782.630434239123;14906;14953.40186392543;11921.94039029808;12156.756864862653;12379.619149738961;12444.315562644051;12459.688507787287;3856.633619806114;3858.189780146173;4090.365993271048;4099.426080348753;4104.076582768883;106890;107501;107614.46192769065;107783;112470.87529124768;11390.430478476042;11392.601258956063;11512;11646.301221926542;11879.346635935106;23437;23789.64315535268;23881.761182387952;23890.044398223876;23911.52176956486;7620.657070431733;7805.765827025199;8250.958745206235;8261.752147435587;8372.623231954454;4530.320451932236;4531.909361812811;4581.152486789954;4646.233371493733;4663.27719203524;3556.6976806971697;3659.5791483979683;3889.8055097245024;4097.405876147942;4097.4263603095;630.6184758221302;709.6664567653298;717.121526130486;717.5264325545115;741.4290995933102;591.3760982163773;631.3844002097918;662.4898827902488;684.2029036172902;706.4666177036407;9457.43255404678;9495.76260593477;9633.133018028411;9655.324127311022;9835.508224588742;571.3943220186616;669.2905520148561;673.8679019247711;682.774684354162;690.1683471417031;4469.865904022885;4630.305454181832;4640.675152739276;4676.3453116563705;4681.227597446383;133226.00160997594;169667;170843;171400;173973.13013435106;118852;146381.26809366097;147448;149681;151043;98566;122531.38734306271;129747.35126324308;130623;131033.34483327523;9043;9145.725628231165;9209.907900920905;9266.490343031199;9314.906850931404;55774;62552.68723656535;65156.67421662861;65552.94094235501;65828.6708566454;93307.53346233226;99054.01891962264;100166.4991675037;102154.97845021455;102749;12256.419144774096;12272.754544908874;12322.753544928872;12391.62825115248;12436.316002619942;12630.179038362478;13663.111897727014;13756.449742010607;13882.236476993457;14236.35936382886;12136.635900922987;12493.312867792358;12652.810207846705;12814.231146131262;12854.421551030038;10875.858034906221;12651.620451386472;12855.357232138169;13110.672233194246;13503;12183.390830458264;12312.569060082855;12369.381530923598;12517.812232816697;12914.741705166032;10333.638322658671;10408.479576021016;10480.213983951387;10487.685369438928;10845.674629761119;10401.635942741968;10751.731206719582;10762;10788.568457261936;10828.566857325619 09:02:52 INFO - PROCESS | 2222 | __end_tp_report 09:02:52 INFO - PROCESS | 2222 | __start_cc_report 09:02:52 INFO - PROCESS | 2222 | _x_x_mozilla_cycle_collect,447 09:02:52 INFO - PROCESS | 2222 | __end_cc_report 09:02:52 INFO - PROCESS | 2222 | __startTimestamp1468512172321__endTimestamp 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | ------- Summary: start ------- 09:02:52 INFO - PROCESS | 2222 | Number of tests: 6 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | [#0] dojo.html Cycles:165 Average:5720.49 Median:6010.70 stddev:678.86 (11.3%) stddev-sans-first:654.74 09:02:52 INFO - PROCESS | 2222 | Values: 3339.6 3342.3 3381.5 3387.4 3395.1 4892.6 5752.4 5802.7 5857.3 5871.1 4744.8 5655.1 5793.0 5852.0 5871.6 4252.2 4560.5 4917.7 5357.4 5426.3 5182.9 5372.4 5402.5 5425.2 5429.2 5257.9 5284.0 5296.3 5297.9 5339.7 5291.6 5294.8 5295.8 5316.2 5316.2 5265.1 5271.2 5287.9 5303.4 5337.7 4807.9 5633.5 5742.9 5796.4 5851.2 6222.5 6258.0 6261.5 6282.1 6290.1 6119.2 6120.1 6223.2 6235.4 6246.5 4798.5 5747.8 5811.3 5912.4 5925.8 4636.3 5378.2 6305.7 6306.2 6326.9 6109.7 6113.2 6224.2 6249.7 6255.5 6179.2 6259.6 6297.5 6297.6 6337.4 6108.4 6166.5 6173.5 6253.5 6255.3 6104.5 6159.4 6198.8 6321.1 6338.7 4898.3 4940.3 4941.7 4951.9 5003.0 4437.4 4441.6 4454.3 4457.4 4513.2 5738.6 5902.9 5930.7 5941.8 6028.6 6256.4 6265.7 6268.7 6268.8 6278.4 5901.1 5997.0 6002.8 6020.4 6052.1 5310.9 5409.5 5437.5 5444.0 5464.8 6311.6 6333.7 6342.9 6353.6 6418.1 6255.0 6262.3 6268.1 6271.3 6278.1 4769.7 6136.4 6179.9 6222.6 6228.5 5239.8 6028.7 6081.8 6255.9 6280.9 6154.6 6226.0 6267.5 6289.0 6312.2 5966.3 5975.2 6116.4 6125.8 6152.9 6144.2 6153.6 6233.0 6234.1 6240.0 4613.3 5945.1 6010.7 6057.6 6084.5 6015.3 6105.4 6136.8 6145.6 6206.1 4919.7 5996.9 6044.9 6065.2 6100.3 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | [#1] ext.html Cycles:180 Average:73054.59 Median:40561.20 stddev:164591.28 (405.8%) stddev-sans-first:164962.69 09:02:52 INFO - PROCESS | 2222 | Values: 434.6 459.8 519.7 547.9 561.1 30737.4 40530.6 40570.6 40610.4 40615.8 33926.7 41466.0 41498.6 41916.4 41951.2 8081.9 9508.8 9646.0 9699.0 9754.5 8070.8 9564.6 9618.3 9660.4 9665.5 9618.4 9620.3 9682.1 9682.2 9702.3 9588.1 9595.1 9626.4 9644.0 9644.7 9478.3 9495.8 9563.4 9573.6 9581.5 39681.0 39721.4 39841.2 40003.4 40070.0 2996.9 3395.8 3514.2 3525.1 3666.7 30624.7 31694.7 32532.7 32619.5 32667.0 3245.4 3390.1 3399.6 3436.2 3436.3 495192.0 501527.0 506653.0 507609.9 507650.0 33448.5 62166.7 62255.0 62857.4 62895.1 34049.8 34129.7 34698.0 34798.8 34826.8 14463.2 14678.3 14708.8 14720.5 14739.3 12460.9 12518.6 12540.7 12571.2 12667.6 6791.5 7345.0 7588.1 7637.2 7677.7 2851.7 3238.9 3242.4 3246.7 3258.1 765.9 829.0 997.4 1062.0 1071.8 30230.8 30357.4 30581.7 31079.8 31779.4 849.7 1039.3 1114.7 1147.9 1194.5 12969.7 14404.0 15313.3 15894.8 15959.6 685247.0 702675.0 704570.0 705472.0 707086.0 58000.0 58830.7 58944.7 59485.7 59496.7 1247.5 1359.7 1383.2 1446.3 1448.9 29140.0 29987.1 30210.9 30586.5 31989.0 57162.7 57204.4 58107.5 58130.8 58228.4 614060.0 621750.0 622025.0 622405.0 624478.0 37796.0 42546.4 44290.3 44850.0 44906.6 48700.5 49004.0 49246.8 50351.2 50372.5 40332.8 40467.6 41458.0 41612.6 42016.4 39327.8 40317.6 40551.8 40979.8 41112.4 33549.0 38816.0 38868.6 38936.6 39710.4 34606.5 35130.5 35671.9 36021.5 36244.0 25769.4 25987.0 26014.3 26125.1 26454.3 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | [#2] jquery.html Cycles:180 Average:35261.11 Median:26293.87 stddev:102325.55 (389.2%) stddev-sans-first:102578.97 09:02:52 INFO - PROCESS | 2222 | Values: 323.4 358.7 381.8 392.0 401.4 15881.2 16933.0 21052.6 21625.8 21993.3 20921.6 21443.0 21484.9 21522.2 21756.8 4727.4 5860.6 6018.1 6026.1 6054.0 5946.5 5964.0 5987.5 5997.6 6009.2 5126.0 5535.8 5746.7 5926.1 5936.7 5842.3 5881.4 5911.7 5912.9 5939.1 5047.1 5122.6 5147.6 5150.2 5155.3 23900.4 25728.0 26091.7 26496.0 26597.3 2146.1 2193.2 2276.6 2277.2 2401.4 10531.9 10629.2 10703.9 11691.8 16025.4 1862.0 1959.8 1971.0 1979.5 1985.9 106840.0 115310.4 120159.4 128776.0 130431.3 11516.3 11700.5 11830.6 11841.4 11942.6 14618.5 14641.0 14816.6 14822.3 14863.9 8656.6 8725.1 8726.4 8865.9 8898.6 8660.3 8718.0 8728.9 8799.6 8870.4 4068.6 4184.0 4622.6 4689.6 4696.7 1912.3 1972.9 2029.6 2031.5 2032.0 722.5 784.1 882.2 898.2 976.6 21543.0 21945.7 21949.0 22070.9 22404.0 967.5 1008.2 1012.5 1066.6 1101.2 9731.0 11178.9 11538.9 11651.1 11652.4 598061.0 611238.9 615717.0 625671.9 626888.0 62387.7 95581.5 109260.0 128137.0 133302.7 824.7 936.3 970.8 972.9 1056.6 15678.5 19818.8 20092.9 20295.5 20368.5 39085.0 51005.0 57516.8 59455.4 60105.7 71329.6 86356.3 88029.6 88766.0 88901.0 8129.9 8349.5 8433.8 8499.7 8512.3 11207.7 12319.2 13238.0 13252.1 13314.8 7140.5 9690.5 9794.3 11138.8 11281.7 11223.2 11331.4 11367.7 11457.3 11521.9 11741.9 11762.0 11769.0 11805.6 11879.4 6036.8 7572.0 7658.1 7676.8 8581.9 8402.2 11002.9 11673.3 11682.5 11763.5 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | [#3] mootools.html Cycles:180 Average:5861.39 Median:2547.49 stddev:3305.79 (129.8%) stddev-sans-first:3299.27 09:02:52 INFO - PROCESS | 2222 | Values: 1561.7 1567.3 1824.8 1901.9 1920.2 8098.1 8733.6 8789.2 9257.2 9285.3 7669.9 8798.6 8848.6 9021.9 9049.9 2344.6 2372.4 2383.0 2386.6 2388.3 2341.9 2363.1 2401.7 2404.8 2414.8 2372.6 2384.7 2387.2 2391.1 2398.4 1969.6 2347.5 2365.3 2372.5 2378.3 2351.4 2361.7 2361.9 2364.2 2366.7 8092.5 8543.7 9033.7 9048.9 9103.5 5246.8 5384.4 5410.3 5413.5 5422.2 3622.2 3652.8 3717.6 3722.2 3726.3 1091.6 1092.9 1098.2 1102.2 1122.2 11753.8 11984.8 11994.2 11995.3 12002.1 4633.1 4641.7 4844.7 4863.8 4864.9 10167.4 10212.9 10247.5 10259.6 10264.6 5295.4 5374.1 5408.6 5410.8 5426.1 4418.9 4795.4 4955.2 4958.3 4959.0 4061.3 4085.6 4122.5 4132.4 4135.1 1310.7 1321.7 1323.7 1336.6 1340.6 946.0 949.9 979.7 994.6 1007.8 6175.7 6250.0 6278.7 6305.3 6365.8 443.2 455.1 461.0 461.8 468.0 4238.0 4249.6 4274.8 4297.3 4314.5 10663.1 11168.3 11205.3 11210.4 11213.9 10250.0 10897.5 11033.9 11147.5 11159.4 8134.7 8291.4 8399.0 8451.7 8477.0 5019.9 6120.2 6331.8 6352.4 6511.1 10140.8 10258.2 10299.4 10376.0 10476.8 10396.3 10522.6 10540.2 10541.9 10596.8 6937.9 7635.0 7732.3 7743.0 7778.8 8582.7 8713.3 8715.1 8782.5 8785.6 7688.3 7826.5 7867.8 7927.1 7960.4 7580.7 7698.3 7699.4 7806.9 7815.3 6388.1 6460.5 7080.5 7096.0 7325.5 5039.6 5150.9 5228.9 5288.7 5324.8 5233.2 5241.6 5270.9 5330.2 5356.1 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | [#4] prototype.html Cycles:180 Average:4561.79 Median:4902.02 stddev:1414.94 (28.9%) stddev-sans-first:1382.29 09:02:52 INFO - PROCESS | 2222 | Values: 300.9 302.7 305.7 318.1 318.4 4336.8 4635.2 5490.6 5638.9 5689.1 4493.0 5645.5 5655.3 5664.0 5679.7 3531.4 4236.8 4252.9 4260.6 4274.6 4121.3 4279.3 4279.5 4289.0 4315.4 3476.4 3690.9 4050.9 4193.6 4275.4 3937.3 4098.8 4172.9 4271.5 4279.3 3271.5 3691.2 3691.8 3698.3 3699.3 4210.6 5255.7 5327.8 5438.5 5515.3 4275.6 4847.1 4865.4 4885.8 4916.0 5216.5 5670.9 6013.6 6028.7 6034.8 3548.0 4014.3 4022.9 4038.8 4047.9 5503.8 5605.1 6031.4 6312.7 6331.6 3610.8 3718.8 3810.7 4126.5 4136.2 3640.5 3832.2 3922.6 4115.2 4155.6 4247.0 4881.3 4881.4 4888.0 4935.8 5268.8 5676.7 5940.5 6024.8 6024.8 1385.7 1420.9 1428.2 1432.1 1432.3 848.9 869.1 877.0 883.6 885.5 4352.4 4528.6 4662.4 4692.7 4758.0 4575.9 5131.3 5144.8 5180.5 5187.4 4483.8 4690.2 4711.3 4720.9 4765.4 2237.9 2611.7 2620.2 2720.3 2739.7 4818.7 4990.9 5071.3 5378.5 5380.7 4869.8 4959.0 5318.8 5357.5 5407.8 4301.0 4754.5 4886.3 5354.0 5387.5 4792.2 4970.7 5190.6 5210.8 5233.8 4425.7 4594.1 4967.8 5449.9 6171.0 5636.2 6381.6 6409.9 6420.6 6438.5 3367.3 3792.9 4069.2 4091.4 4094.0 5820.6 5925.6 6022.7 6199.8 6237.8 4996.3 5145.5 5660.8 6044.3 6053.8 5066.9 5938.3 6001.0 6061.3 6074.8 5671.7 5818.8 5853.4 5868.7 5876.5 5421.6 5483.3 5649.4 5680.7 6011.2 5125.5 5531.6 5593.7 5870.7 5882.8 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - PROCESS | 2222 | [#5] yui.html Cycles:180 Average:26206.05 Median:23900.78 stddev:43188.74 (180.7%) stddev-sans-first:43267.21 09:02:52 INFO - PROCESS | 2222 | Values: 631.8 717.9 794.6 796.7 827.3 15447.0 16130.4 16295.1 16302.5 16350.9 12363.1 14013.9 14707.3 14777.1 14790.9 897.1 917.1 919.6 920.0 922.9 718.9 885.2 919.9 923.2 923.4 956.2 969.9 969.9 972.8 974.3 942.0 963.1 965.4 966.1 966.5 689.4 711.8 714.0 717.5 717.7 12628.0 15122.6 15450.1 15458.2 15585.9 14698.9 14755.9 14782.6 14906.0 14953.4 11921.9 12156.8 12379.6 12444.3 12459.7 3856.6 3858.2 4090.4 4099.4 4104.1 106890.0 107501.0 107614.5 107783.0 112470.9 11390.4 11392.6 11512.0 11646.3 11879.3 23437.0 23789.6 23881.8 23890.0 23911.5 7620.7 7805.8 8251.0 8261.8 8372.6 4530.3 4531.9 4581.2 4646.2 4663.3 3556.7 3659.6 3889.8 4097.4 4097.4 630.6 709.7 717.1 717.5 741.4 591.4 631.4 662.5 684.2 706.5 9457.4 9495.8 9633.1 9655.3 9835.5 571.4 669.3 673.9 682.8 690.2 4469.9 4630.3 4640.7 4676.3 4681.2 133226.0 169667.0 170843.0 171400.0 173973.1 118852.0 146381.3 147448.0 149681.0 151043.0 98566.0 122531.4 129747.4 130623.0 131033.3 9043.0 9145.7 9209.9 9266.5 9314.9 55774.0 62552.7 65156.7 65552.9 65828.7 93307.5 99054.0 100166.5 102155.0 102749.0 12256.4 12272.8 12322.8 12391.6 12436.3 12630.2 13663.1 13756.4 13882.2 14236.4 12136.6 12493.3 12652.8 12814.2 12854.4 10875.9 12651.6 12855.4 13110.7 13503.0 12183.4 12312.6 12369.4 12517.8 12914.7 10333.6 10408.5 10480.2 10487.7 10845.7 10401.6 10751.7 10762.0 10788.6 10828.6 09:02:52 INFO - PROCESS | 2222 | -------- Summary: end -------- 09:02:52 INFO - PROCESS | 2222 | 09:02:52 INFO - TEST-INFO | 2222: exit 0 09:02:52 INFO - TEST-OK | dromaeo_css | took 1113350ms 09:02:52 INFO - TEST-START | kraken 09:02:52 INFO - operating with platform_type : mac_ 09:02:52 INFO - Initialising browser for kraken test... 09:02:52 INFO - TEST-INFO | started process 2226 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpuU4ujT/profile http://localhost:53253/getInfo.html) 09:02:55 INFO - PROCESS | 2226 | __metrics Screen width/height:1600/1200 09:02:55 INFO - PROCESS | 2226 | colorDepth:24 09:02:55 INFO - PROCESS | 2226 | Browser inner width/height: 1024/689 09:02:55 INFO - PROCESS | 2226 | __metrics 09:02:55 ERROR - PROCESS | 2226 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 09:02:56 INFO - TEST-INFO | 2226: exit 0 09:02:56 INFO - Browser initialized. 09:02:56 INFO - Running cycle 1/1 for kraken test... 09:02:56 INFO - TEST-INFO | started process 2228 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/tmpuU4ujT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:03:08 INFO - PROCESS | 2228 | RSS: Main: 254406656 09:03:08 INFO - PROCESS | 2228 | 09:03:11 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-beat-detection) 09:03:12 INFO - PROCESS | 2228 | RSS: Main: 267059200 09:03:12 INFO - PROCESS | 2228 | 09:03:14 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-dft) 09:03:15 INFO - PROCESS | 2228 | RSS: Main: 271142912 09:03:15 INFO - PROCESS | 2228 | 09:03:18 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-fft) 09:03:19 INFO - PROCESS | 2228 | RSS: Main: 271380480 09:03:19 INFO - PROCESS | 2228 | 09:03:21 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53253/tests/kraken/driver.html?testName=audio-oscillator) 09:03:22 INFO - PROCESS | 2228 | RSS: Main: 272371712 09:03:22 INFO - PROCESS | 2228 | 09:03:24 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53253/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:03:24 INFO - PROCESS | 2228 | RSS: Main: 273571840 09:03:24 INFO - PROCESS | 2228 | 09:03:27 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53253/tests/kraken/driver.html?testName=imaging-darkroom) 09:03:28 INFO - PROCESS | 2228 | RSS: Main: 273362944 09:03:28 INFO - PROCESS | 2228 | 09:03:31 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53253/tests/kraken/driver.html?testName=imaging-desaturate) 09:03:32 INFO - PROCESS | 2228 | RSS: Main: 273559552 09:03:32 INFO - PROCESS | 2228 | 09:03:35 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53253/tests/kraken/driver.html?testName=json-parse-financial) 09:03:35 INFO - PROCESS | 2228 | RSS: Main: 273670144 09:03:35 INFO - PROCESS | 2228 | 09:03:37 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53253/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:03:38 INFO - PROCESS | 2228 | RSS: Main: 273592320 09:03:38 INFO - PROCESS | 2228 | 09:03:40 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:03:40 INFO - PROCESS | 2228 | RSS: Main: 273760256 09:03:40 INFO - PROCESS | 2228 | 09:03:43 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:03:43 INFO - PROCESS | 2228 | RSS: Main: 273600512 09:03:43 INFO - PROCESS | 2228 | 09:03:46 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:03:47 INFO - PROCESS | 2228 | RSS: Main: 273596416 09:03:47 INFO - PROCESS | 2228 | 09:03:50 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:03:51 INFO - PROCESS | 2228 | RSS: Main: 273723392 09:03:51 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | Cycle 1(1): loaded http://localhost:53253/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53253/tests/kraken/driver.html?testName=ai-astar) 09:03:53 INFO - PROCESS | 2228 | RSS: Main: 274698240 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | __start_tp_report 09:03:53 INFO - PROCESS | 2228 | _x_x_mozilla_page_load 09:03:53 INFO - PROCESS | 2228 | _x_x_mozilla_page_load_details 09:03:53 INFO - PROCESS | 2228 | |i|pagename|runs| 09:03:53 INFO - PROCESS | 2228 | |0;ai-astar;106;118;106;116;118;117;114;114;116;119 09:03:53 INFO - PROCESS | 2228 | |1;audio-beat-detection;154;107;135;163;127;163;163;131;197;140 09:03:53 INFO - PROCESS | 2228 | |2;audio-dft;197;205;208;243;273;196;196;196;198;193 09:03:53 INFO - PROCESS | 2228 | |3;audio-fft;73;100;110;149;58;60;61;64;130;51 09:03:53 INFO - PROCESS | 2228 | |4;audio-oscillator;71;72;120;74;71;75;130;64;104;146 09:03:53 INFO - PROCESS | 2228 | |5;imaging-gaussian-blur;90;88;98;88;84;133;135;87;89;89 09:03:53 INFO - PROCESS | 2228 | |6;imaging-darkroom;95;101;151;125;96;95;107;99;95;108 09:03:53 INFO - PROCESS | 2228 | |7;imaging-desaturate;151;138;92;93;91;90;76;147;153;91 09:03:53 INFO - PROCESS | 2228 | |8;json-parse-financial;57;66;69;92;75;58;57;57;58;58 09:03:53 INFO - PROCESS | 2228 | |9;json-stringify-tinderbox;70;102;100;96;88;77;75;71;69;78 09:03:53 INFO - PROCESS | 2228 | |10;stanford-crypto-aes;89;85;86;84;84;78;97;109;103;109 09:03:53 INFO - PROCESS | 2228 | |11;stanford-crypto-ccm;137;140;135;137;150;129;135;150;168;152 09:03:53 INFO - PROCESS | 2228 | |12;stanford-crypto-pbkdf2;175;201;172;233;239;181;245;182;237;242 09:03:53 INFO - PROCESS | 2228 | |13;stanford-crypto-sha256-iterative;70;81;92;86;68;74;89;92;89;62 09:03:53 INFO - PROCESS | 2228 | __end_tp_report 09:03:53 INFO - PROCESS | 2228 | __start_cc_report 09:03:53 INFO - PROCESS | 2228 | _x_x_mozilla_cycle_collect,1150 09:03:53 INFO - PROCESS | 2228 | __end_cc_report 09:03:53 INFO - PROCESS | 2228 | __startTimestamp1468512233448__endTimestamp 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | ------- Summary: start ------- 09:03:53 INFO - PROCESS | 2228 | Number of tests: 14 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#0] ai-astar Cycles:10 Average:114.40 Median:116.50 stddev:4.72 (4.1%) stddev-sans-first:3.91 09:03:53 INFO - PROCESS | 2228 | Values: 106.0 118.0 106.0 116.0 118.0 117.0 114.0 114.0 116.0 119.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:158.50 stddev:25.29 (16.0%) stddev-sans-first:26.73 09:03:53 INFO - PROCESS | 2228 | Values: 154.0 107.0 135.0 163.0 127.0 163.0 163.0 131.0 197.0 140.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#2] audio-dft Cycles:10 Average:210.50 Median:201.50 stddev:26.40 (13.1%) stddev-sans-first:27.55 09:03:53 INFO - PROCESS | 2228 | Values: 197.0 205.0 208.0 243.0 273.0 196.0 196.0 196.0 198.0 193.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#3] audio-fft Cycles:10 Average:85.60 Median:59.00 stddev:34.38 (58.3%) stddev-sans-first:36.16 09:03:53 INFO - PROCESS | 2228 | Values: 73.0 100.0 110.0 149.0 58.0 60.0 61.0 64.0 130.0 51.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:71.00 stddev:29.74 (41.9%) stddev-sans-first:30.49 09:03:53 INFO - PROCESS | 2228 | Values: 71.0 72.0 120.0 74.0 71.0 75.0 130.0 64.0 104.0 146.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#5] imaging-gaussian-blur Cycles:10 Average:98.10 Median:88.50 stddev:19.26 (21.8%) stddev-sans-first:20.20 09:03:53 INFO - PROCESS | 2228 | Values: 90.0 88.0 98.0 88.0 84.0 133.0 135.0 87.0 89.0 89.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:95.00 stddev:17.99 (18.9%) stddev-sans-first:18.53 09:03:53 INFO - PROCESS | 2228 | Values: 95.0 101.0 151.0 125.0 96.0 95.0 107.0 99.0 95.0 108.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#7] imaging-desaturate Cycles:10 Average:112.20 Median:90.50 stddev:30.78 (34.0%) stddev-sans-first:29.27 09:03:53 INFO - PROCESS | 2228 | Values: 151.0 138.0 92.0 93.0 91.0 90.0 76.0 147.0 153.0 91.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:62.00 stddev:11.47 (18.5%) stddev-sans-first:11.82 09:03:53 INFO - PROCESS | 2228 | Values: 57.0 66.0 69.0 92.0 75.0 58.0 57.0 57.0 58.0 58.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:76.00 stddev:12.81 (16.9%) stddev-sans-first:12.75 09:03:53 INFO - PROCESS | 2228 | Values: 70.0 102.0 100.0 96.0 88.0 77.0 75.0 71.0 69.0 78.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:84.50 stddev:11.26 (13.3%) stddev-sans-first:11.87 09:03:53 INFO - PROCESS | 2228 | Values: 89.0 85.0 86.0 84.0 84.0 78.0 97.0 109.0 103.0 109.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#11] stanford-crypto-ccm Cycles:10 Average:143.30 Median:145.00 stddev:11.59 (8.0%) stddev-sans-first:12.06 09:03:53 INFO - PROCESS | 2228 | Values: 137.0 140.0 135.0 137.0 150.0 129.0 135.0 150.0 168.0 152.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:210.70 Median:235.00 stddev:31.12 (13.2%) stddev-sans-first:30.21 09:03:53 INFO - PROCESS | 2228 | Values: 175.0 201.0 172.0 233.0 239.0 181.0 245.0 182.0 237.0 242.0 09:03:53 INFO - PROCESS | 2228 | 09:03:53 INFO - PROCESS | 2228 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.30 Median:87.50 stddev:11.01 (12.6%) stddev-sans-first:11.02 09:03:53 INFO - PROCESS | 2228 | Values: 70.0 81.0 92.0 86.0 68.0 74.0 89.0 92.0 89.0 62.0 09:03:53 INFO - PROCESS | 2228 | -------- Summary: end -------- 09:03:53 INFO - PROCESS | 2228 | 09:03:54 INFO - TEST-INFO | 2228: exit 0 09:03:54 INFO - TEST-OK | kraken | took 61411ms 09:03:54 INFO - SUITE-END | took 1174s 09:03:54 INFO - Completed test suite (00:19:35) 09:03:54 INFO - javascript benchmark 09:03:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7364.098169339435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3339.5825521809775, 3342.348242092792, 3381.45896656535, 3387.3733359328526, 3395.1172695099267, 4892.6330525210615, 5752.424757524245, 5802.738876750545, 5857.297124345074, 5871.119332100187, 4744.833930812422, 5655.095184770437, 5793.015187418138, 5852.0, 5871.588988770788, 4252.2345977724, 4560.521145279731, 4917.704937703731, 5357.4374690657505, 5426.321709786277, 5182.922256166161, 5372.409035006146, 5402.459754024605, 5425.159100339453, 5429.239906413105, 5257.921131182997, 5284.0, 5296.285001524783, 5297.920531192035, 5339.679619222859, 5291.629585928987, 5294.814681486168, 5295.841124766263, 5316.175992721134, 5316.229146773735, 5265.104932161542, 5271.20931860224, 5287.920681189786, 5303.363596368422, 5337.653052551572, 4807.927881081787, 5633.464820842013, 5742.856428589319, 5796.449337312949, 5851.180834683148, 6222.540307349775, 6258.0, 6261.530385221126, 6282.120503129519, 6290.119383286344, 6119.204503414572, 6120.142398366908, 6223.222097237845, 6235.407636274592, 6246.469050130744, 4798.47216806151, 5747.770089196469, 5811.331696854873, 5912.438318359749, 5925.82222533329, 4636.281376386598, 5378.1663842104535, 6305.747770089237, 6306.243250809932, 6326.873462530723, 6109.663968481687, 6113.172264937315, 6224.221972253468, 6249.6562689052535, 6255.468285195719, 6179.227596550431, 6259.561830671809, 6297.4647154992335, 6297.559170857996, 6337.397947195009, 6108.389161083945, 6166.4758495527485, 6173.506119510428, 6253.499720022387, 6255.311915689271, 6104.489471593149, 6159.4456498914415, 6198.752049918043, 6321.1150438938585, 6338.651374174465, 4898.314236006961, 4940.283658869444, 4941.703497790144, 4951.90096198074, 5003.024410240041, 4437.356583295404, 4441.622462090694, 4454.309582014793, 4457.442819647544, 4513.187626227311, 5738.598298119092, 5902.8819423611285, 5930.733117009745, 5941.792037278675, 6028.577999540078, 6256.436920677161, 6265.71804268809, 6268.717907694165, 6268.780592679234, 6278.434940855345, 5901.144334071536, 5997.017892644135, 6002.789902353396, 6020.367861374492, 6052.12244224585, 5310.911263191037, 5409.5131438169965, 5437.48343907336, 5444.0, 5464.754086066137, 6311.6096689333035, 6333.714982825784, 6342.873142537216, 6353.618782873043, 6418.069379939882, 6255.0, 6262.279837818527, 6268.059791031382, 6271.278802937721, 6278.0896769967185, 4769.73766442849, 6136.365905528456, 6179.907301390573, 6222.595531290452, 6228.501719862491, 5239.816606418757, 6028.668423236764, 6081.787137450168, 6255.936490796485, 6280.874382512233, 6154.599951003171, 6225.968870155621, 6267.5299352549655, 6289.0, 6312.242530896322, 5966.254218222723, 5975.223220981418, 6116.366205733216, 6125.816225513242, 6152.907706384318, 6144.218176728878, 6153.6000159991245, 6233.0338797486465, 6234.064890266496, 6240.0, 4613.308003799457, 5945.078512830518, 6010.699465026819, 6057.575969682256, 6084.452399284086, 6015.2781666200335, 6105.399096011559, 6136.764169924414, 6145.631262124287, 6206.06908963659, 4919.655624106278, 5996.910046349395, 6044.884409724384, 6065.150878877049, 6100.298465676504], "value": 5680.358470023738, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.5806296923468, 459.8091791906359, 519.6855902179182, 547.9232907392966, 561.121844313649, 30737.385252294967, 40530.59469405305, 40570.59429405709, 40610.390844137364, 40615.79692101535, 33926.66073339272, 41466.0, 41498.58501414985, 41916.371254431135, 41951.16097678045, 8081.919180808205, 9508.80982380352, 9645.951770241174, 9698.981606931276, 9754.512274386288, 8070.757877263692, 9564.617415303379, 9618.326717129803, 9660.372075815085, 9665.5167241638, 9618.422894626345, 9620.326577139604, 9682.12860842524, 9682.177014953737, 9702.320837541374, 9588.089131532493, 9595.088466595627, 9626.422414655108, 9643.951780241125, 9644.662436814679, 9478.289128315404, 9495.810083798286, 9563.426194428357, 9573.617055317778, 9581.520923953774, 39681.0, 39721.40417893705, 39841.203175936316, 40003.39994900079, 40070.0, 2996.895108671186, 3395.8079405358885, 3514.191735900757, 3525.065857547752, 3666.651668091527, 30624.693753062405, 31694.683053169636, 32532.6746732532, 32619.51070733941, 32667.0, 3245.383377158332, 3390.135515443571, 3399.6260411354733, 3436.2096717755057, 3436.3127374525193, 495192.0, 501527.0, 506653.0, 507609.9239007637, 507649.99999999633, 33448.49827252593, 62166.71582915413, 62255.0, 62857.37142628607, 62895.05657415142, 34049.82975085109, 34129.658703413144, 34697.959061228205, 34798.82600586981, 34826.82586587051, 14463.204523751294, 14678.339474723663, 14708.779368309484, 14720.484783032756, 14739.263036848115, 12460.937695311466, 12518.561850335194, 12540.749185016248, 12571.245725256515, 12667.606563278032, 6791.4906382021545, 7344.96327518359, 7588.089429268523, 7637.19809420014, 7677.654505547152, 2851.6578010638855, 3238.9149634872583, 3242.4325742994884, 3246.740260779132, 3258.1040213940882, 765.9004329437138, 828.995855020721, 997.4464172384396, 1061.9575216991389, 1071.8499410082595, 30230.84884575563, 30357.392852142835, 30581.69418305833, 31079.84460077685, 31779.364412711617, 849.7365816596874, 1039.3296323871061, 1114.7324642086003, 1147.9196456247982, 1194.4863708605383, 12969.675758105934, 14404.0, 15313.310901009481, 15894.785629207996, 15959.601009974844, 685247.0, 702675.0, 704570.0, 705472.0, 707086.0, 58000.0, 58830.7058464705, 58944.705276473345, 59485.702571486865, 59496.70251648714, 1247.5072346423112, 1359.6804750883534, 1383.1700979412474, 1446.305773228856, 1448.876845468147, 29140.0, 29987.100386988426, 30210.9426170083, 30586.541201881544, 31989.04032879017, 57162.7141864288, 57204.42795571991, 58107.547311315866, 58130.83738325125, 58228.4177158223, 614060.0, 621750.0, 622025.0, 622405.0, 624478.0, 37796.0, 42546.361804572334, 44290.3356449647, 44850.0, 44906.55093449024, 48700.5129948696, 49004.0, 49246.75376623094, 50351.24473132979, 50372.49627503678, 40332.798336008134, 40467.595324046386, 41458.0, 41612.58387416087, 42016.369754453095, 39327.80336098416, 40317.59682403138, 40551.797241013606, 40979.795101024305, 41112.38331424971, 33549.0, 38816.0, 38868.61131388763, 38936.61063389443, 39710.40434393544, 34606.480902785974, 35130.47304290387, 35671.92984210478, 36021.45967810538, 36244.0, 25769.355766105997, 25987.0, 26014.34964125912, 26125.08562200314, 26454.338641534116], "value": 19122.23539862099, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4339905165958, 358.65031594195653, 381.8129116732801, 391.97060220483473, 401.4079233131132, 15881.205939703012, 16933.0, 21052.57894842104, 21625.81058041807, 21993.340199794013, 20921.581568368623, 21443.035063422143, 21484.89257553714, 21522.246721364754, 21756.782432175674, 4727.385439892809, 5860.619059761112, 6018.127371531147, 6026.126211699301, 6053.969730151343, 5946.464818166364, 5964.0, 5987.461128498434, 5997.640141591497, 6009.248843894513, 5125.974805038988, 5535.750891209906, 5746.655200687951, 5926.081457374114, 5936.673482958436, 5842.328132264759, 5881.411858814127, 5911.6748578828365, 5912.911306330387, 5939.109133629947, 5047.066292735819, 5122.564582010534, 5147.562457191143, 5150.175971844525, 5155.278261043457, 23900.40248993772, 25727.970881164732, 26091.73908260912, 26496.0, 26597.335066623295, 2146.066461089431, 2193.1775584155944, 2276.612975794119, 2277.1587743732657, 2401.3876461502205, 10531.894681053169, 10629.20280978922, 10703.946480267627, 11691.766164676745, 16025.35898564056, 1862.0, 1959.8138176873174, 1970.9704354434696, 1979.5150188203982, 1985.9007049647605, 106840.0, 115310.42344788306, 120159.39920300343, 128776.0, 130431.34784326113, 11516.251443656136, 11700.473478693479, 11830.645080647595, 11841.407929603485, 11942.582009629621, 14618.488352907598, 14641.0, 14816.555503334917, 14822.258887055605, 14863.925680371745, 8656.567171641393, 8725.127487251224, 8726.432781869158, 8865.867011994826, 8898.644054237888, 8660.30717542595, 8718.0, 8728.912710872937, 8799.604017819214, 8870.423422477648, 4068.572799856032, 4183.979080104641, 4622.560856718674, 4689.554492323224, 4696.671233013724, 1912.311567835578, 1972.9148968067504, 2029.5737895041912, 2031.4718173275055, 2031.9796802032085, 722.4653756220359, 784.1022029775875, 882.245679943639, 898.1512470715112, 976.6337623391229, 21543.0, 21945.67081493779, 21949.0, 22070.88964555199, 22404.0, 967.5259123029665, 1008.1732978957331, 1012.4785735346303, 1066.5520481397832, 1101.218135124055, 9730.95134524323, 11178.888211117948, 11538.88461115395, 11651.067914566815, 11652.41737913101, 598061.0, 611238.9438052782, 615717.0, 625671.8716406389, 626888.0, 62387.68806156031, 95581.52209238909, 109260.0, 128137.0, 133302.66697333095, 824.7031068815222, 936.2697096264924, 970.7864269860619, 972.863799068131, 1056.5984925728328, 15678.529644110695, 19818.801811981695, 20092.89953550223, 20295.4926126848, 20368.490787730425, 39085.0, 51005.0, 57516.84966300734, 59455.405445946715, 60105.69947150236, 71329.57340853258, 86356.27287454341, 88029.55985220033, 88766.0, 88901.0, 8129.9187008129165, 8349.457285276438, 8433.789155271168, 8499.660013599387, 8512.276456501268, 11207.71980700489, 12319.199252048587, 13238.0, 13252.138610990254, 13314.800277995644, 7140.5358651687475, 9690.467024313448, 9794.314397992071, 11138.832917506083, 11281.661550153509, 11223.214374993671, 11331.376774277494, 11367.715807104889, 11457.312561246352, 11521.942390287995, 11741.941290293495, 11762.0, 11769.0, 11805.645830625095, 11879.406029698308, 6036.8188954331445, 7571.977782999445, 7658.081030276179, 7676.808079797826, 8581.8712719308, 8402.159784021549, 11002.944985275022, 11673.299602023906, 11682.532698692297, 11763.470643820878], "value": 9605.858967494176, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1561.7423125184343, 1567.3260497985868, 1824.8083951185126, 1901.8763780354277, 1920.1839218332204, 8098.06872209696, 8733.606987685553, 8789.165029322212, 9257.213136883365, 9285.303602229826, 7669.884951725729, 8798.604062817172, 8848.646054157842, 9021.909780902206, 9049.864252036225, 2344.601417758981, 2372.406898275431, 2383.0467812874904, 2386.59427897257, 2388.319328991238, 2341.8711970841596, 2363.0783994242174, 2401.711794584652, 2404.843685160459, 2414.806815454768, 2372.6085195942737, 2384.7376788553247, 2387.212219967407, 2391.1391898916377, 2398.352444839892, 1969.6257711034857, 2347.4835536182013, 2365.254944692425, 2372.489914668346, 2378.2865140457966, 2351.4245455544656, 2361.7165940087298, 2361.881905904715, 2364.243442098529, 2366.727826299963, 8092.514449133071, 8543.700970466003, 9033.728988130366, 9048.864267036, 9103.544822758835, 5246.842594722164, 5384.380796208447, 5410.323709536308, 5413.485718856702, 5422.15956526739, 3622.239329740731, 3652.7808331500196, 3717.5538935327663, 3722.181120153562, 3726.329260733067, 1091.6288461922904, 1092.918031147667, 1098.203802243375, 1102.1898904305328, 1122.2032357026521, 11753.764924701458, 11984.760304793943, 11994.16040877139, 11995.280283183038, 12002.099842511847, 4633.142868569325, 4641.74470404131, 4844.660873738875, 4863.781129849165, 4864.902701945941, 10167.389956602627, 10212.897871021194, 10247.487625618689, 10259.58961641541, 10264.589416423409, 5295.364556253197, 5374.11327131019, 5408.648437851527, 5410.83767486976, 5426.104692725735, 4418.9337159942625, 4795.400574928134, 4955.207166853358, 4958.305837182797, 4959.008198360342, 4061.3429966417757, 4085.5914408558906, 4122.525909520384, 4132.442120313719, 4135.1316223592785, 1310.724747802953, 1321.7422602592594, 1323.6558494791423, 1336.5789776220458, 1340.5710172744627, 945.9621615135318, 949.9335046546676, 979.6620166042704, 994.6121012805012, 1007.8253501470426, 6175.69121543921, 6250.0, 6278.6860656966965, 6305.306416294204, 6365.777197798055, 443.2464809823313, 455.07619532349383, 460.9723416595015, 461.8452818305838, 468.04051694027106, 4237.957620423818, 4249.575042495788, 4274.786260686953, 4297.333913243452, 4314.482262128502, 10663.146948244123, 11168.274062185932, 11205.271657342246, 11210.383428911487, 11213.934676205747, 10250.0, 10897.455127243606, 11033.944830275957, 11147.498362573704, 11159.386233757059, 8134.715284965117, 8291.419600627898, 8399.034111077304, 8451.746447606582, 8477.0, 5019.949800502094, 6120.234970628671, 6331.841703957438, 6352.36476352361, 6511.055896895018, 10140.847887281845, 10258.17934565248, 10299.3820370778, 10375.990962621057, 10476.842847357448, 10396.324238924446, 10522.631707890187, 10540.15678745714, 10541.894581054092, 10596.841047384141, 6937.930620693728, 7634.961825190839, 7732.304092631465, 7742.961285193538, 7778.766637000899, 8582.742517724479, 8713.346499012472, 8715.128487151234, 8782.473051616924, 8785.560721963748, 7688.308052275322, 7826.491278067135, 7867.84264314722, 7927.088384835587, 7960.442769006114, 7580.696772129053, 7698.34564062061, 7699.3840492761565, 7806.92193078062, 7815.25755053269, 6388.1376014237485, 6460.515461340325, 7080.539764915264, 7096.0, 7325.4505912057875, 5039.647224694236, 5150.918307155539, 5228.895422091461, 5288.735563221747, 5324.8136315228785, 5233.162693968947, 5241.554467870274, 5270.947290527046, 5330.200469929541, 5356.143576624824], "value": 4632.937588206634, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.8807237078069, 302.70637481642797, 305.70957590289225, 318.1410192480301, 318.3585076071716, 4336.8290561548365, 4635.238609328455, 5490.588205884565, 5638.887222255553, 5689.146628005801, 4493.0, 5645.5483561315095, 5655.321361436623, 5664.037113690672, 5679.659220446766, 3531.364354416204, 4236.788160591974, 4252.89367765806, 4260.636596289189, 4274.572542745716, 4121.340585506319, 4279.315309550472, 4279.486461624594, 4289.0, 4315.352697095429, 3476.4263896457055, 3690.870819521317, 4050.926504476316, 4193.622573968342, 4275.380069889864, 3937.310970580151, 4098.7540747555095, 4172.874813755592, 4271.466066741657, 4279.293916503773, 3271.525628783813, 3691.2248427830186, 3691.7969511676847, 3698.31581157484, 3699.26014797039, 4210.599958023928, 5255.684658920439, 5327.801244719945, 5438.53772429344, 5515.255440515519, 4275.593818587229, 4847.054824309226, 4865.44047434546, 4885.780139893714, 4916.041371932474, 5216.478352164791, 5670.914936275959, 6013.609115407485, 6028.668423236721, 6034.788782392595, 3547.9822600887087, 4014.2974979378782, 4022.8591999279884, 4038.7778672173017, 4047.8583249586122, 5503.834884953458, 5605.131204663284, 6031.431827724823, 6312.685839934025, 6331.588446750947, 3610.7833529988284, 3718.7768733876055, 3810.733248672622, 4126.463559737275, 4136.21411931732, 3640.4903313536124, 3832.176082142297, 3922.5685174630767, 4115.156392939441, 4155.625993660585, 4247.0, 4881.341018962395, 4881.389826271716, 4888.0, 4935.75321233944, 5268.81559145428, 5676.659400435905, 5940.495057920039, 6024.759009639653, 6024.849378765478, 1385.6951470676436, 1420.921849298278, 1428.1502506008908, 1432.0977783996225, 1432.3124900048035, 848.9278411334982, 869.1091631078069, 876.9517676527724, 883.571467838098, 885.5439448683933, 4352.410315862057, 4528.5961351981, 4662.368171140074, 4692.747481209039, 4757.976210118927, 4575.9084818303445, 5131.281620573122, 5144.794208231704, 5180.513353590298, 5187.351581052369, 4483.775811209492, 4690.241159565163, 4711.316859055418, 4720.905581888412, 4765.448996208613, 2237.876916769593, 2611.686597608299, 2620.187741800048, 2720.326998895665, 2739.7260273972843, 4818.68678535894, 4990.850274491771, 5071.323290614275, 5378.489043540857, 5380.677159370451, 4869.784248167076, 4958.975205123951, 5318.813841515528, 5357.517823395913, 5407.756650950717, 4300.956990430118, 4754.524547545356, 4886.291487734258, 5354.0, 5387.542058925035, 4792.161371759998, 4970.701757894538, 5190.624484511683, 5210.843674689614, 5233.801803242571, 4425.668074894332, 4594.058218065222, 4967.7516124192925, 5449.901787811642, 6170.969145154246, 5636.154576813511, 6381.617102973836, 6409.8718025640155, 6420.55056146084, 6438.517111216771, 3367.343368043306, 3792.8672496463596, 4069.1861627673993, 4091.40674602187, 4094.0174358154422, 5820.563457740602, 5925.585209035498, 6022.698865056817, 6199.752009919733, 6237.75048998035, 4996.250562415521, 5145.511176438233, 5660.754633980518, 6044.304904935812, 6053.75784968614, 5066.885285237242, 5938.317093534299, 6000.969995149996, 6061.272647282354, 6074.848128796815, 5671.723862130987, 5818.796342128006, 5853.385394533512, 5868.706564671664, 5876.529877609866, 5421.566274697936, 5483.314585676791, 5649.4350564944825, 5680.6591604503865, 6011.248593925759, 5125.513076257749, 5531.612787104864, 5593.720313984366, 5870.679097203095, 5882.794102206402], "value": 4114.942377446035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.8451979265079, 717.9138503379592, 794.5987276425404, 796.7092011415835, 827.2761333832894, 15446.99594526355, 16130.435434759785, 16295.103769292684, 16302.51092467225, 16350.918245408771, 12363.072769542297, 14013.92993035036, 14707.264636768172, 14777.113373197615, 14790.926045369784, 897.0536084430922, 917.092078841945, 919.6367434863225, 919.9724008279729, 922.8523436250201, 718.881384571545, 885.1679421343916, 919.9448033118001, 923.1691477670117, 923.3582660051267, 956.1920177450044, 969.9078587534173, 969.9321047526676, 972.8394814855541, 974.28390133252, 941.9858702119474, 963.0610155098793, 965.4255717847869, 966.0677446264353, 966.5215718219491, 689.4002218070261, 711.7580022792224, 713.9714411423537, 717.5049216040967, 717.6626985316892, 12627.989760819113, 15122.621934451727, 15450.0729956203, 15458.227088645523, 15585.922070389688, 14698.926505367404, 14755.852441475556, 14782.630434239123, 14906.0, 14953.40186392543, 11921.94039029808, 12156.756864862653, 12379.619149738961, 12444.315562644051, 12459.688507787287, 3856.633619806114, 3858.189780146173, 4090.365993271048, 4099.426080348753, 4104.076582768883, 106890.0, 107501.0, 107614.46192769065, 107783.0, 112470.87529124768, 11390.430478476042, 11392.601258956063, 11512.0, 11646.301221926542, 11879.346635935106, 23437.0, 23789.64315535268, 23881.761182387952, 23890.044398223876, 23911.52176956486, 7620.657070431733, 7805.765827025199, 8250.958745206235, 8261.752147435587, 8372.623231954454, 4530.320451932236, 4531.909361812811, 4581.152486789954, 4646.233371493733, 4663.27719203524, 3556.6976806971697, 3659.5791483979683, 3889.8055097245024, 4097.405876147942, 4097.4263603095, 630.6184758221302, 709.6664567653298, 717.121526130486, 717.5264325545115, 741.4290995933102, 591.3760982163773, 631.3844002097918, 662.4898827902488, 684.2029036172902, 706.4666177036407, 9457.43255404678, 9495.76260593477, 9633.133018028411, 9655.324127311022, 9835.508224588742, 571.3943220186616, 669.2905520148561, 673.8679019247711, 682.774684354162, 690.1683471417031, 4469.865904022885, 4630.305454181832, 4640.675152739276, 4676.3453116563705, 4681.227597446383, 133226.00160997594, 169667.0, 170843.0, 171400.0, 173973.13013435106, 118852.0, 146381.26809366097, 147448.0, 149681.0, 151043.0, 98566.0, 122531.38734306271, 129747.35126324308, 130623.0, 131033.34483327523, 9043.0, 9145.725628231165, 9209.907900920905, 9266.490343031199, 9314.906850931404, 55774.0, 62552.68723656535, 65156.67421662861, 65552.94094235501, 65828.6708566454, 93307.53346233226, 99054.01891962264, 100166.4991675037, 102154.97845021455, 102749.0, 12256.419144774096, 12272.754544908874, 12322.753544928872, 12391.62825115248, 12436.316002619942, 12630.179038362478, 13663.111897727014, 13756.449742010607, 13882.236476993457, 14236.35936382886, 12136.635900922987, 12493.312867792358, 12652.810207846705, 12814.231146131262, 12854.421551030038, 10875.858034906221, 12651.620451386472, 12855.357232138169, 13110.672233194246, 13503.0, 12183.390830458264, 12312.569060082855, 12369.381530923598, 12517.812232816697, 12914.741705166032, 10333.638322658671, 10408.479576021016, 10480.213983951387, 10487.685369438928, 10845.674629761119, 10401.635942741968, 10751.731206719582, 10762.0, 10788.568457261936, 10828.566857325619], "value": 8016.829094904136, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1642.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 106.0, 116.0, 118.0, 117.0, 114.0, 114.0, 116.0, 119.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 107.0, 135.0, 163.0, 127.0, 163.0, 163.0, 131.0, 197.0, 140.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 205.0, 208.0, 243.0, 273.0, 196.0, 196.0, 196.0, 198.0, 193.0], "value": 210.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 100.0, 110.0, 149.0, 58.0, 60.0, 61.0, 64.0, 130.0, 51.0], "value": 85.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 120.0, 74.0, 71.0, 75.0, 130.0, 64.0, 104.0, 146.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 98.0, 88.0, 84.0, 133.0, 135.0, 87.0, 89.0, 89.0], "value": 98.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 151.0, 125.0, 96.0, 95.0, 107.0, 99.0, 95.0, 108.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 138.0, 92.0, 93.0, 91.0, 90.0, 76.0, 147.0, 153.0, 91.0], "value": 112.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 66.0, 69.0, 92.0, 75.0, 58.0, 57.0, 57.0, 58.0, 58.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 102.0, 100.0, 96.0, 88.0, 77.0, 75.0, 71.0, 69.0, 78.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 86.0, 84.0, 84.0, 78.0, 97.0, 109.0, 103.0, 109.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 140.0, 135.0, 137.0, 150.0, 129.0, 135.0, 150.0, 168.0, 152.0], "value": 143.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 201.0, 172.0, 233.0, 239.0, 181.0, 245.0, 182.0, 237.0, 242.0], "value": 210.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 81.0, 92.0, 86.0, 68.0, 74.0, 89.0, 92.0, 89.0, 62.0], "value": 80.3, "unit": "score"}]}]} 09:03:54 INFO - Return code: 0 09:03:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:03:54 ERROR - # TBPL SUCCESS # 09:03:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:03:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:03:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:03:54 INFO - 2016-07-14 09:03:54.789 screenresolution[2233:25048] starting screenresolution argv=screenresolution get 09:03:54 INFO - 2016-07-14 09:03:54.792 screenresolution[2233:25048] Display 0: 1600x1200x32@60 09:03:54 INFO - 2016-07-14 09:03:54.798 screenresolution[2234:25051] starting screenresolution argv=screenresolution list 09:03:54 INFO - Available Modes on Display 0 09:03:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:03:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:03:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:03:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:03:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:03:55 INFO - Intel Iris: 09:03:55 INFO - Chipset Model: Intel Iris 09:03:55 INFO - Type: GPU 09:03:55 INFO - Bus: Built-In 09:03:55 INFO - VRAM (Dynamic, Max): 1536 MB 09:03:55 INFO - Vendor: Intel (0x8086) 09:03:55 INFO - Device ID: 0x0a2e 09:03:55 INFO - Revision ID: 0x0009 09:03:55 INFO - Displays: 09:03:55 INFO - Display: 09:03:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:03:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:03:55 INFO - Display Serial Number: 1600x1200 60 09:03:55 INFO - Main Display: Yes 09:03:55 INFO - Mirror: Off 09:03:55 INFO - Online: Yes 09:03:55 INFO - Rotation: Supported 09:03:55 INFO - Return code: 0 09:03:55 INFO - Running post-action listener: _resource_record_post_action 09:03:55 INFO - ##### 09:03:55 INFO - ##### Finished run-tests step (success) 09:03:55 INFO - ##### 09:03:55 INFO - Running post-run listener: _resource_record_post_run 09:03:55 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 12288; Write bytes: 706941440; Read time: 1; Write time: 2050 09:03:55 INFO - TinderboxPrint: CPU usage
54.4% 09:03:55 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 1 09:03:55 INFO - TinderboxPrint: I/O write bytes / time
706,941,440 / 2,050 09:03:55 INFO - TinderboxPrint: CPU idle
2,209.4 (45.6%) 09:03:55 INFO - TinderboxPrint: CPU system
978.2 (20.2%) 09:03:55 INFO - TinderboxPrint: CPU user
1,654.1 (34.2%) 09:03:55 INFO - TinderboxPrint: Swap in / out
406,732,800 / 0 09:03:55 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392407552; Write bytes: 387119104; Read time: 29247; Write time: 854 09:03:55 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 12288; Write bytes: 296753664; Read time: 1; Write time: 1139 09:03:55 INFO - Running post-run listener: _upload_blobber_files 09:03:55 INFO - Blob upload gear active. 09:03:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:03:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:03:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:03:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:03:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:03:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:03:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:03:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:57 INFO - (blobuploader) - INFO - Done attempting. 09:03:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:03:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:03:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:58 INFO - (blobuploader) - INFO - Done attempting. 09:03:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:03:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:03:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:04:00 INFO - (blobuploader) - INFO - Done attempting. 09:04:00 INFO - (blobuploader) - INFO - Iteration through files over. 09:04:00 INFO - Return code: 0 09:04:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:04:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:04:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775f7005527da2178deadfa7897a8d86fffc9cc4a822848e48722ffaea87dd241d7a958248199860d5baf80725fa5d1c4599c2e1740674b79a4d959d523d2855", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3745d87da2b5c99538b6bb1d45f52e4842057e067c1ec15b432fad1f3f06f79474a7840cde8082fa5cebfc4066c38497d0e19045c7f07cd5f2b1ba704f4c004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21d83c5c9da459890c7fdb40b06a5cc46d9ebd1324e76701048f7c3ded778e31120ec1df2fc689bcc2a25997e9f2f2b8c450f9ab67d02fd3e5a2e7bf69ee62b6"} 09:04:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:04:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:04:00 INFO - Contents: 09:04:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775f7005527da2178deadfa7897a8d86fffc9cc4a822848e48722ffaea87dd241d7a958248199860d5baf80725fa5d1c4599c2e1740674b79a4d959d523d2855", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3745d87da2b5c99538b6bb1d45f52e4842057e067c1ec15b432fad1f3f06f79474a7840cde8082fa5cebfc4066c38497d0e19045c7f07cd5f2b1ba704f4c004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21d83c5c9da459890c7fdb40b06a5cc46d9ebd1324e76701048f7c3ded778e31120ec1df2fc689bcc2a25997e9f2f2b8c450f9ab67d02fd3e5a2e7bf69ee62b6"} 09:04:00 INFO - Running post-run listener: copy_logs_to_upload_dir 09:04:00 INFO - Copying logs to upload dir... 09:04:00 INFO - mkdir: /builds/slave/test/build/upload/logs 09:04:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1295.575223 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 35 secs) (at 2016-07-14 09:04:00.420540) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 09:04:00.424497) ========= 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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775f7005527da2178deadfa7897a8d86fffc9cc4a822848e48722ffaea87dd241d7a958248199860d5baf80725fa5d1c4599c2e1740674b79a4d959d523d2855", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3745d87da2b5c99538b6bb1d45f52e4842057e067c1ec15b432fad1f3f06f79474a7840cde8082fa5cebfc4066c38497d0e19045c7f07cd5f2b1ba704f4c004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21d83c5c9da459890c7fdb40b06a5cc46d9ebd1324e76701048f7c3ded778e31120ec1df2fc689bcc2a25997e9f2f2b8c450f9ab67d02fd3e5a2e7bf69ee62b6"} build_url:https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011517 build_url: 'https://queue.taskcluster.net/v1/task/H6K75C6nTluH1OPiZ6n88A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/775f7005527da2178deadfa7897a8d86fffc9cc4a822848e48722ffaea87dd241d7a958248199860d5baf80725fa5d1c4599c2e1740674b79a4d959d523d2855", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3745d87da2b5c99538b6bb1d45f52e4842057e067c1ec15b432fad1f3f06f79474a7840cde8082fa5cebfc4066c38497d0e19045c7f07cd5f2b1ba704f4c004", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/21d83c5c9da459890c7fdb40b06a5cc46d9ebd1324e76701048f7c3ded778e31120ec1df2fc689bcc2a25997e9f2f2b8c450f9ab67d02fd3e5a2e7bf69ee62b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 09:04:00.457759) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 09:04:00.458087) ========= 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.yUCKMwYVAf/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.a7OQnF9XLK/Listeners TMPDIR=/var/folders/r0/nyzdpbbd3x92v1nh78hx68lh00000w/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.005116 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 09:04:00.507252) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 09:04:00.507597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 09:04:00.507949) ========= ========= Total master_lag: 0.18 =========