builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0382 starttime: 1467316817.36 results: success (0) buildid: 20160630105630 builduid: 192c151303244a3abad9e5a992256459 revision: 8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:17.364349) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:17.364737) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:17.365010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:17.642613) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:17.643060) ========= 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.iVq53PldDx/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.rUfllImX16/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-06-30 13:00:17-- 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% 57.9M=0s 2016-06-30 13:00:18 (57.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.549092 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:18.221887) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:18.222367) ========= 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.iVq53PldDx/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.rUfllImX16/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.021571 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:18.285958) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-30 13:00:18.286258) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc --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 8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iVq53PldDx/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.rUfllImX16/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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-06-30 13:00:18,370 truncating revision to first 12 chars 2016-06-30 13:00:18,370 Setting DEBUG logging. 2016-06-30 13:00:18,370 attempt 1/10 2016-06-30 13:00:18,370 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8347f75bb6a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 13:00:20,238 unpacking tar archive at: fx-team-8347f75bb6a0/testing/mozharness/ program finished with exit code 0 elapsedTime=2.140517 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-30 13:00:20.454271) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:20.454576) ========= script_repo_revision: 8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:20.454938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:20.455195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 13:00:20.473343) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-06-30 13:00:20.473619) ========= /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.iVq53PldDx/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.rUfllImX16/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:00:20 INFO - MultiFileLogger online at 20160630 13:00:20 in /builds/slave/test 13:00:20 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 13:00:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:00:20 INFO - {'append_to_log': False, 13:00:20 INFO - 'base_work_dir': '/builds/slave/test', 13:00:20 INFO - 'blob_upload_branch': 'Fx-Team', 13:00:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:00:20 INFO - 'branch': 'Fx-Team', 13:00:20 INFO - 'buildbot_json_path': 'buildprops.json', 13:00:20 INFO - 'config_files': ('talos/mac_config.py',), 13:00:20 INFO - 'default_actions': ('clobber', 13:00:20 INFO - 'read-buildbot-config', 13:00:20 INFO - 'download-and-extract', 13:00:20 INFO - 'populate-webroot', 13:00:20 INFO - 'create-virtualenv', 13:00:20 INFO - 'install', 13:00:20 INFO - 'run-tests'), 13:00:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:00:20 INFO - 'download_minidump_stackwalk': True, 13:00:20 INFO - 'download_symbols': 'ondemand', 13:00:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:00:20 INFO - 'tooltool.py': '/tools/tooltool.py', 13:00:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:00:20 INFO - '/tools/misc-python/virtualenv.py')}, 13:00:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:00:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:00:20 INFO - 'installer_path': 'installer.exe', 13:00:20 INFO - 'log_level': 'info', 13:00:20 INFO - 'log_name': 'talos', 13:00:20 INFO - 'log_to_console': True, 13:00:20 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:00:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:00:20 INFO - 'opt_config_files': (), 13:00:20 INFO - 'pip_index': False, 13:00:20 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:00:20 INFO - 'cmd': ('bash', 13:00:20 INFO - '-c', 13:00:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:00:20 INFO - 'enabled': True, 13:00:20 INFO - 'halt_on_failure': False, 13:00:20 INFO - 'name': 'check_screen_resolution'},), 13:00:20 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:00:20 INFO - 'cmd': ('bash', 13:00:20 INFO - '-c', 13:00:20 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:00:20 INFO - 'enabled': True, 13:00:20 INFO - 'halt_on_failure': False, 13:00:20 INFO - 'name': 'check_screen_resolution'},), 13:00:20 INFO - 'run_cmd_checks_enabled': True, 13:00:20 INFO - 'sps_profile': False, 13:00:20 INFO - 'sps_profile_interval': 0, 13:00:20 INFO - 'suite': 'dromaeojs-e10s', 13:00:20 INFO - 'system_bits': '32', 13:00:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:00:20 INFO - 'title': 't-yosemite-r7-0382', 13:00:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:00:20 INFO - 'use_talos_json': True, 13:00:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:00:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:00:20 INFO - 'work_dir': 'build'} 13:00:20 INFO - ##### 13:00:20 INFO - ##### Running clobber step. 13:00:20 INFO - ##### 13:00:20 INFO - Running pre-action listener: _resource_record_pre_action 13:00:20 INFO - Running main action method: clobber 13:00:20 INFO - rmtree: /builds/slave/test/build 13:00:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:00:22 INFO - Running post-action listener: _resource_record_post_action 13:00:22 INFO - ##### 13:00:22 INFO - ##### Finished clobber step (success) 13:00:22 INFO - ##### 13:00:22 INFO - ##### 13:00:22 INFO - ##### Running read-buildbot-config step. 13:00:22 INFO - ##### 13:00:22 INFO - Running pre-action listener: _resource_record_pre_action 13:00:22 INFO - Running main action method: read_buildbot_config 13:00:22 INFO - Using buildbot properties: 13:00:22 INFO - { 13:00:22 INFO - "project": "", 13:00:22 INFO - "product": "firefox", 13:00:22 INFO - "script_repo_revision": "production", 13:00:22 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 13:00:22 INFO - "repository": "", 13:00:22 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 13:00:22 INFO - "buildid": "20160630105630", 13:00:22 INFO - "pgo_build": "False", 13:00:22 INFO - "basedir": "/builds/slave/test", 13:00:22 INFO - "buildnumber": 41, 13:00:22 INFO - "slavename": "t-yosemite-r7-0382", 13:00:22 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 13:00:22 INFO - "platform": "yosemite_r7", 13:00:22 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 13:00:22 INFO - "branch": "fx-team", 13:00:22 INFO - "repo_path": "integration/fx-team", 13:00:22 INFO - "revision": "8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc", 13:00:22 INFO - "stage_platform": "macosx64", 13:00:22 INFO - "builduid": "192c151303244a3abad9e5a992256459", 13:00:22 INFO - "slavebuilddir": "test" 13:00:22 INFO - } 13:00:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 13:00:22 INFO - Running post-action listener: _resource_record_post_action 13:00:22 INFO - ##### 13:00:22 INFO - ##### Finished read-buildbot-config step (success) 13:00:22 INFO - ##### 13:00:22 INFO - ##### 13:00:22 INFO - ##### Running download-and-extract step. 13:00:22 INFO - ##### 13:00:22 INFO - Running pre-action listener: _resource_record_pre_action 13:00:22 INFO - Running main action method: download_and_extract 13:00:22 INFO - mkdir: /builds/slave/test/build/tests 13:00: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')]} 13:00:22 INFO - https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:00:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:00:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 13:00:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:00:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:00:52 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 13:00:52 INFO - retry: attempt #1 caught exception: timed out 13:00:52 INFO - retry: Failed, sleeping 30 seconds before retrying 13:01:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:23 INFO - Downloaded 1199 bytes. 13:01:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 13:01:23 INFO - Using the following test package requirements: 13:01:23 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:01:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 13:01:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 13:01:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'jsshell-mac.zip'], 13:01:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 13:01:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 13:01:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 13:01:23 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 13:01:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 13:01:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 13:01:23 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 13:01:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:01:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:01:23 INFO - https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:01:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:01:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:01:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:24 INFO - Downloaded 18788668 bytes. 13:01:24 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'] 13:01:24 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 13:01:27 INFO - Return code: 0 13:01:27 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 13:01:27 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')]} 13:01:27 INFO - https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:01:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:01:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 13:01:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:30 INFO - Downloaded 18788668 bytes. 13:01:30 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'] 13:01:30 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 13:01:34 INFO - Return code: 0 13:01:34 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')]} 13:01:34 INFO - https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:01:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:01:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 13:01:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:35 INFO - Downloaded 14405242 bytes. 13:01:35 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'] 13:01:35 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 13:01:35 INFO - Return code: 0 13:01:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:35 INFO - https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 13:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 13:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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 13:01:38 INFO - Downloaded 112419779 bytes. 13:01:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:01:38 INFO - mkdir: /builds/slave/test/properties 13:01:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:01:38 INFO - Writing to file /builds/slave/test/properties/build_url 13:01:38 INFO - Contents: 13:01:38 INFO - build_url:https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 13:01:39 INFO - Running post-action listener: _resource_record_post_action 13:01:39 INFO - Running post-action listener: set_extra_try_arguments 13:01:39 INFO - ##### 13:01:39 INFO - ##### Finished download-and-extract step (success) 13:01:39 INFO - ##### 13:01:39 INFO - ##### 13:01:39 INFO - ##### Running populate-webroot step. 13:01:39 INFO - ##### 13:01:39 INFO - Running pre-action listener: _resource_record_pre_action 13:01:39 INFO - Running main action method: populate_webroot 13:01:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:01:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:01:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:01:39 INFO - '--tppagecycles', 13:01:39 INFO - '7'], 13:01:39 INFO - 'tests': ['tsvgm']}}, 13:01:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:01:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:01:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:01:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:01:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:01:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['damp', 'tps']}, 13:01:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'tests': ['damp', 'tps']}, 13:01:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['dromaeo_dom']}, 13:01:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:01:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['basic_compositor_video']}, 13:01:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:01:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['a11yr', 13:01:39 INFO - 'ts_paint', 13:01:39 INFO - 'tpaint', 13:01:39 INFO - 'sessionrestore', 13:01:39 INFO - 'sessionrestore_no_auto_restore', 13:01:39 INFO - 'tabpaint']}, 13:01:39 INFO - 'other-e10s': {'tests': ['a11yr', 13:01:39 INFO - 'ts_paint', 13:01:39 INFO - 'tpaint', 13:01:39 INFO - 'sessionrestore', 13:01:39 INFO - 'sessionrestore_no_auto_restore', 13:01:39 INFO - 'tabpaint']}, 13:01:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:01:39 INFO - 'ts_paint', 13:01:39 INFO - 'tpaint', 13:01:39 INFO - 'sessionrestore', 13:01:39 INFO - 'sessionrestore_no_auto_restore', 13:01:39 INFO - 'tabpaint']}, 13:01:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:01:39 INFO - 'ts_paint', 13:01:39 INFO - 'tpaint', 13:01:39 INFO - 'sessionrestore', 13:01:39 INFO - 'sessionrestore_no_auto_restore', 13:01:39 INFO - 'tabpaint']}, 13:01:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['a11yr', 13:01:39 INFO - 'ts_paint', 13:01:39 INFO - 'tpaint', 13:01:39 INFO - 'sessionrestore', 13:01:39 INFO - 'sessionrestore_no_auto_restore', 13:01:39 INFO - 'tabpaint']}, 13:01:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['a11yr', 13:01:39 INFO - 'ts_paint', 13:01:39 INFO - 'tpaint', 13:01:39 INFO - 'sessionrestore', 13:01:39 INFO - 'sessionrestore_no_auto_restore', 13:01:39 INFO - 'tabpaint']}, 13:01:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['tsvgx', 13:01:39 INFO - 'tsvgr_opacity', 13:01:39 INFO - 'tart', 13:01:39 INFO - 'tscrollx', 13:01:39 INFO - 'cart']}, 13:01:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:01:39 INFO - 'tsvgr_opacity', 13:01:39 INFO - 'tart', 13:01:39 INFO - 'tscrollx', 13:01:39 INFO - 'cart']}, 13:01:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'talos_options': ['--disable-e10s'], 13:01:39 INFO - 'tests': ['tp5o']}, 13:01:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'tests': ['tp5o']}, 13:01:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'talos_options': ['--disable-e10s', 13:01:39 INFO - '--xperf_path', 13:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:39 INFO - 'tests': ['tp5n']}, 13:01:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:01:39 INFO - 'talos_options': ['--xperf_path', 13:01:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:01:39 INFO - 'tests': ['tp5n']}}, 13:01:39 INFO - 'talos.zip': {'path': '', 13:01:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:01:39 INFO - Running post-action listener: _resource_record_post_action 13:01:39 INFO - ##### 13:01:39 INFO - ##### Finished populate-webroot step (success) 13:01:39 INFO - ##### 13:01:39 INFO - ##### 13:01:39 INFO - ##### Running create-virtualenv step. 13:01:39 INFO - ##### 13:01:39 INFO - Running pre-action listener: _resource_record_pre_action 13:01:39 INFO - Running main action method: create_virtualenv 13:01:39 INFO - Creating virtualenv /builds/slave/test/build/venv 13:01:39 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 13:01:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:01:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:01:39 INFO - Using real prefix '/tools/python27' 13:01:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:01:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:01:43 INFO - Installing pip.................done. 13:01:43 INFO - Return code: 0 13:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:01: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')]} 13:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:01: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', 'pip>=1.5'] in /builds/slave/test/build 13:01: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 pip>=1.5 13:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:43 INFO - 'HOME': '/Users/cltbld', 13:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:43 INFO - 'LOGNAME': 'cltbld', 13:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:43 INFO - 'MOZ_NO_REMOTE': '1', 13:01:43 INFO - 'NO_EM_RESTART': '1', 13:01:43 INFO - 'PAGER': '/bin/cat', 13:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:43 INFO - 'PWD': '/builds/slave/test', 13:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:43 INFO - 'SHELL': '/bin/bash', 13:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:01:43 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:43 INFO - 'USER': 'cltbld', 13:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:43 INFO - 'XPC_FLAGS': '0x0', 13:01:43 INFO - 'XPC_SERVICE_NAME': '0', 13:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:43 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 13:01:43 INFO - Cleaning up... 13:01:43 INFO - Return code: 0 13:01:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:01: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')]} 13:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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')]} 13:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01: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', '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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:01: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:01: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 psutil>=3.1.1 13:01:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:01:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:43 INFO - 'HOME': '/Users/cltbld', 13:01:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:43 INFO - 'LOGNAME': 'cltbld', 13:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:43 INFO - 'MOZ_NO_REMOTE': '1', 13:01:43 INFO - 'NO_EM_RESTART': '1', 13:01:43 INFO - 'PAGER': '/bin/cat', 13:01:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:43 INFO - 'PWD': '/builds/slave/test', 13:01:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:43 INFO - 'SHELL': '/bin/bash', 13:01:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:01:43 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:01:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:43 INFO - 'USER': 'cltbld', 13:01:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:43 INFO - 'XPC_FLAGS': '0x0', 13:01:43 INFO - 'XPC_SERVICE_NAME': '0', 13:01:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:43 INFO - Downloading/unpacking psutil>=3.1.1 13:01:43 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 13:01:43 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 13:01:43 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 13:01:43 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 13:01:43 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 13:01:43 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 13:01:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:46 INFO - Installing collected packages: psutil 13:01:46 INFO - Running setup.py install for psutil 13:01:47 INFO - building 'psutil._psutil_osx' extension 13:01:47 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 13:01:47 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 13:01:47 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 13:01:47 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 13:01:47 INFO - building 'psutil._psutil_posix' extension 13:01:47 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 13:01:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:01:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:01:47 INFO - ^ 13:01:47 INFO - 1 warning generated. 13:01:47 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 13:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:01:47 INFO - Successfully installed psutil 13:01:47 INFO - Cleaning up... 13:01:47 INFO - Return code: 0 13:01:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:47 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:01:47 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 13:01:47 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 13:01:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:01:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:47 INFO - 'HOME': '/Users/cltbld', 13:01:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:47 INFO - 'LOGNAME': 'cltbld', 13:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:47 INFO - 'MOZ_NO_REMOTE': '1', 13:01:47 INFO - 'NO_EM_RESTART': '1', 13:01:47 INFO - 'PAGER': '/bin/cat', 13:01:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:47 INFO - 'PWD': '/builds/slave/test', 13:01:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:47 INFO - 'SHELL': '/bin/bash', 13:01:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:01:47 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:01:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:47 INFO - 'USER': 'cltbld', 13:01:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:47 INFO - 'XPC_FLAGS': '0x0', 13:01:47 INFO - 'XPC_SERVICE_NAME': '0', 13:01:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:01:48 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 13:01:48 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 13:01:48 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 13:01:48 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 13:01:48 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 13:01:48 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 13:01:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:01:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:01:50 INFO - Installing collected packages: mozsystemmonitor 13:01:50 INFO - Running setup.py install for mozsystemmonitor 13:01:50 INFO - Successfully installed mozsystemmonitor 13:01:50 INFO - Cleaning up... 13:01:50 INFO - Return code: 0 13:01:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:50 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:01:50 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 13:01:50 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 13:01:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:01:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:50 INFO - 'HOME': '/Users/cltbld', 13:01:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:50 INFO - 'LOGNAME': 'cltbld', 13:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:50 INFO - 'MOZ_NO_REMOTE': '1', 13:01:50 INFO - 'NO_EM_RESTART': '1', 13:01:50 INFO - 'PAGER': '/bin/cat', 13:01:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:50 INFO - 'PWD': '/builds/slave/test', 13:01:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:50 INFO - 'SHELL': '/bin/bash', 13:01:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:01:50 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:01:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:50 INFO - 'USER': 'cltbld', 13:01:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:50 INFO - 'XPC_FLAGS': '0x0', 13:01:50 INFO - 'XPC_SERVICE_NAME': '0', 13:01:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:51 INFO - Downloading/unpacking jsonschema==2.5.1 13:01:51 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 13:01:51 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 13:01:51 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 13:01:51 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 13:01:51 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 13:01:51 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 13:01:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:01:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:53 INFO - Downloading functools32-3.2.3-2.tar.gz 13:01:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:01:53 INFO - warning: no files found matching '*.txt' 13:01:53 INFO - no previously-included directories found matching 'build' 13:01:53 INFO - no previously-included directories found matching 'dist' 13:01:53 INFO - no previously-included directories found matching '.git*' 13:01:53 INFO - Installing collected packages: jsonschema, functools32 13:01:54 INFO - Running setup.py install for functools32 13:01:54 INFO - warning: no files found matching '*.txt' 13:01:54 INFO - no previously-included directories found matching 'build' 13:01:54 INFO - no previously-included directories found matching 'dist' 13:01:54 INFO - no previously-included directories found matching '.git*' 13:01:54 INFO - Successfully installed jsonschema functools32 13:01:54 INFO - Cleaning up... 13:01:54 INFO - Return code: 0 13:01:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:01:54 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')]} 13:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:54 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')]} 13:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:54 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:01:54 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 13:01:54 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 13:01:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:01:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:54 INFO - 'HOME': '/Users/cltbld', 13:01:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:54 INFO - 'LOGNAME': 'cltbld', 13:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:54 INFO - 'MOZ_NO_REMOTE': '1', 13:01:54 INFO - 'NO_EM_RESTART': '1', 13:01:54 INFO - 'PAGER': '/bin/cat', 13:01:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:54 INFO - 'PWD': '/builds/slave/test', 13:01:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:54 INFO - 'SHELL': '/bin/bash', 13:01:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:01:54 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:01:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:54 INFO - 'USER': 'cltbld', 13:01:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:54 INFO - 'XPC_FLAGS': '0x0', 13:01:54 INFO - 'XPC_SERVICE_NAME': '0', 13:01:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:54 INFO - Downloading/unpacking blobuploader==1.2.4 13:01:54 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 13:01:54 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 13:01:54 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 13:01:54 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 13:01:54 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 13:01:54 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 13:01:56 INFO - Downloading blobuploader-1.2.4.tar.gz 13:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:01:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:01:56 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 13:01:56 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 13:01:56 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 13:01:56 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 13:01:56 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 13:01:56 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 13:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:01:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:01:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:01:57 INFO - Downloading docopt-0.6.1.tar.gz 13:01:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:01:58 INFO - Installing collected packages: blobuploader, requests, docopt 13:01:58 INFO - Running setup.py install for blobuploader 13:01:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:01:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:01:58 INFO - Running setup.py install for requests 13:01:58 INFO - Running setup.py install for docopt 13:01:58 INFO - Successfully installed blobuploader requests docopt 13:01:58 INFO - Cleaning up... 13:01:59 INFO - Return code: 0 13:01:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 13:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:01:59 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:01:59 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 13:01:59 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 13:01:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:01:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:01:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:01:59 INFO - 'HOME': '/Users/cltbld', 13:01:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:01:59 INFO - 'LOGNAME': 'cltbld', 13:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:01:59 INFO - 'MOZ_NO_REMOTE': '1', 13:01:59 INFO - 'NO_EM_RESTART': '1', 13:01:59 INFO - 'PAGER': '/bin/cat', 13:01:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:01:59 INFO - 'PWD': '/builds/slave/test', 13:01:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:01:59 INFO - 'SHELL': '/bin/bash', 13:01:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:01:59 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:01:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:01:59 INFO - 'USER': 'cltbld', 13:01:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:01:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:01:59 INFO - 'XPC_FLAGS': '0x0', 13:01:59 INFO - 'XPC_SERVICE_NAME': '0', 13:01:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-lei6JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-tWT5I3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-fodmRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-GkMjLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-rYjAWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-f_YUaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:01:59 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-fSZzTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-sn1P6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-E4wnLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-OchlKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-hmZ07g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-O55KQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-kmSVZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-CgWhg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-CCbrmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-CDTk4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:00 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qJ_50X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:02:01 INFO - Running setup.py install for manifestparser 13:02:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:02:01 INFO - Running setup.py install for mozcrash 13:02:01 INFO - Running setup.py install for mozdebug 13:02:01 INFO - Running setup.py install for mozdevice 13:02:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:02:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:02:01 INFO - Running setup.py install for mozfile 13:02:01 INFO - Running setup.py install for mozhttpd 13:02:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:02:01 INFO - Running setup.py install for mozinfo 13:02:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Running setup.py install for mozInstall 13:02:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Running setup.py install for mozleak 13:02:02 INFO - Running setup.py install for mozlog 13:02:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Running setup.py install for moznetwork 13:02:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Running setup.py install for mozprocess 13:02:02 INFO - Running setup.py install for mozprofile 13:02:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:02:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:02:03 INFO - Running setup.py install for mozrunner 13:02:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:02:03 INFO - Running setup.py install for mozscreenshot 13:02:03 INFO - Running setup.py install for moztest 13:02:03 INFO - Running setup.py install for mozversion 13:02:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:02:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:02:03 INFO - Cleaning up... 13:02:03 INFO - Return code: 0 13:02:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02:03 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')]} 13:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:03 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')]} 13:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:03 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:02:03 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 13:02:03 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 13:02:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:02:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:03 INFO - 'HOME': '/Users/cltbld', 13:02:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:03 INFO - 'LOGNAME': 'cltbld', 13:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:03 INFO - 'MOZ_NO_REMOTE': '1', 13:02:03 INFO - 'NO_EM_RESTART': '1', 13:02:03 INFO - 'PAGER': '/bin/cat', 13:02:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:03 INFO - 'PWD': '/builds/slave/test', 13:02:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:03 INFO - 'SHELL': '/bin/bash', 13:02:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:02:03 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:02:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:03 INFO - 'USER': 'cltbld', 13:02:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:03 INFO - 'XPC_FLAGS': '0x0', 13:02:03 INFO - 'XPC_SERVICE_NAME': '0', 13:02:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:02:03 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-qUNI2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-y1ydmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-LOrIf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-GXG27a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-rw6J9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-tIBOg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-eKxq5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-EvJeo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-1xXJbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-aBr4qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:02:04 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)) 13:02:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:02:04 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-wAlaza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:02:05 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)) 13:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:02:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-oI9VQo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:02:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-AWRSpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:02:05 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)) 13:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:02:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-SGJ_4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-MvMdPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:02:05 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)) 13:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:02:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-weVXVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:02:05 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)) 13:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:02:05 INFO - Running setup.py (path:/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/pip-ShfYLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 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)) 13:02:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:02:08 INFO - Downloading blessings-1.6.tar.gz 13:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:02:08 INFO - Installing collected packages: blessings 13:02:08 INFO - Running setup.py install for blessings 13:02:08 INFO - Successfully installed blessings 13:02:08 INFO - Cleaning up... 13:02:08 INFO - Return code: 0 13:02:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:02:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:08 INFO - Reading from file tmpfile_stdout 13:02:08 INFO - Current package versions: 13:02:08 INFO - blessings == 1.6 13:02:08 INFO - blobuploader == 1.2.4 13:02:08 INFO - docopt == 0.6.1 13:02:08 INFO - functools32 == 3.2.3-2 13:02:08 INFO - jsonschema == 2.5.1 13:02:08 INFO - manifestparser == 1.1 13:02:08 INFO - mozInstall == 1.12 13:02:08 INFO - mozcrash == 0.17 13:02:08 INFO - mozdebug == 0.1 13:02:08 INFO - mozdevice == 0.48 13:02:08 INFO - mozfile == 1.2 13:02:08 INFO - mozhttpd == 0.7 13:02:08 INFO - mozinfo == 0.9 13:02:08 INFO - mozleak == 0.1 13:02:08 INFO - mozlog == 3.2 13:02:08 INFO - moznetwork == 0.27 13:02:08 INFO - mozprocess == 0.22 13:02:08 INFO - mozprofile == 0.28 13:02:08 INFO - mozrunner == 6.11 13:02:08 INFO - mozscreenshot == 0.1 13:02:08 INFO - mozsystemmonitor == 0.3 13:02:08 INFO - moztest == 0.7 13:02:08 INFO - mozversion == 1.4 13:02:08 INFO - psutil == 3.1.1 13:02:08 INFO - requests == 1.2.3 13:02:08 INFO - wsgiref == 0.1.2 13:02:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:02: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')]} 13:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02: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')]} 13:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:08 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:02:08 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 13:02:08 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 13:02:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:02:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:08 INFO - 'HOME': '/Users/cltbld', 13:02:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:08 INFO - 'LOGNAME': 'cltbld', 13:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:08 INFO - 'MOZ_NO_REMOTE': '1', 13:02:08 INFO - 'NO_EM_RESTART': '1', 13:02:08 INFO - 'PAGER': '/bin/cat', 13:02:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:08 INFO - 'PWD': '/builds/slave/test', 13:02:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:08 INFO - 'SHELL': '/bin/bash', 13:02:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:02:08 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:02:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:08 INFO - 'USER': 'cltbld', 13:02:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:08 INFO - 'XPC_FLAGS': '0x0', 13:02:08 INFO - 'XPC_SERVICE_NAME': '0', 13:02:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 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)) 13:02:09 INFO - Cleaning up... 13:02:09 INFO - Return code: 0 13:02:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:02:09 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')]} 13:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:09 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')]} 13:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:02:09 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 0x108071a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108106618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa0259d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, '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.iVq53PldDx/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.rUfllImX16/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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 13:02:09 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 13:02:09 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 13:02:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:02:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:09 INFO - 'HOME': '/Users/cltbld', 13:02:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:09 INFO - 'LOGNAME': 'cltbld', 13:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:09 INFO - 'MOZ_NO_REMOTE': '1', 13:02:09 INFO - 'NO_EM_RESTART': '1', 13:02:09 INFO - 'PAGER': '/bin/cat', 13:02:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:09 INFO - 'PWD': '/builds/slave/test', 13:02:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:09 INFO - 'SHELL': '/bin/bash', 13:02:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:02:09 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:02:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:09 INFO - 'USER': 'cltbld', 13:02:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:09 INFO - 'XPC_FLAGS': '0x0', 13:02:09 INFO - 'XPC_SERVICE_NAME': '0', 13:02:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:02:09 INFO - Cleaning up... 13:02:09 INFO - Return code: 0 13:02:09 INFO - Running post-action listener: _resource_record_post_action 13:02:09 INFO - Running post-action listener: _start_resource_monitoring 13:02:09 INFO - Starting resource monitoring. 13:02:09 INFO - ##### 13:02:09 INFO - ##### Finished create-virtualenv step (success) 13:02:09 INFO - ##### 13:02:09 INFO - ##### 13:02:09 INFO - ##### Running install step. 13:02:09 INFO - ##### 13:02:09 INFO - Running pre-action listener: _resource_record_pre_action 13:02:09 INFO - Running main action method: install 13:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:02:09 INFO - Reading from file tmpfile_stdout 13:02:09 INFO - Detecting whether we're running mozinstall >=1.0... 13:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:02:09 INFO - Reading from file tmpfile_stdout 13:02:09 INFO - Output received: 13:02:09 INFO - Usage: mozinstall [options] installer 13:02:09 INFO - Options: 13:02:09 INFO - -h, --help show this help message and exit 13:02:09 INFO - -d DEST, --destination=DEST 13:02:09 INFO - Directory to install application into. [default: 13:02:09 INFO - "/builds/slave/test"] 13:02:09 INFO - --app=APP Application being installed. [default: firefox] 13:02:09 INFO - mkdir: /builds/slave/test/build/application 13:02:09 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'] 13:02:09 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 13:02:44 INFO - Reading from file tmpfile_stdout 13:02:44 INFO - Output received: 13:02:44 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:02:44 INFO - Running post-action listener: _resource_record_post_action 13:02:44 INFO - ##### 13:02:44 INFO - ##### Finished install step (success) 13:02:44 INFO - ##### 13:02:44 INFO - ##### 13:02:44 INFO - ##### Running run-tests step. 13:02:44 INFO - ##### 13:02:44 INFO - Running pre-action listener: _resource_record_pre_action 13:02:44 INFO - Running main action method: run_tests 13:02:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:02:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:02:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:02:44 INFO - 2016-06-30 13:02:44.137 screenresolution[2549:80238] starting screenresolution argv=screenresolution get 13:02:44 INFO - 2016-06-30 13:02:44.140 screenresolution[2549:80238] Display 0: 1600x1200x32@60 13:02:44 INFO - 2016-06-30 13:02:44.146 screenresolution[2550:80240] starting screenresolution argv=screenresolution list 13:02:44 INFO - Available Modes on Display 0 13:02:44 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:02:44 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:02:44 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:02:44 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:02:44 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:02:44 INFO - Intel Iris: 13:02:44 INFO - Chipset Model: Intel Iris 13:02:44 INFO - Type: GPU 13:02:44 INFO - Bus: Built-In 13:02:44 INFO - VRAM (Dynamic, Max): 1536 MB 13:02:44 INFO - Vendor: Intel (0x8086) 13:02:44 INFO - Device ID: 0x0a2e 13:02:44 INFO - Revision ID: 0x0009 13:02:44 INFO - Displays: 13:02:44 INFO - Display: 13:02:44 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:02:44 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:02:44 INFO - Display Serial Number: 1600x1200 60 13:02:44 INFO - Main Display: Yes 13:02:44 INFO - Mirror: Off 13:02:44 INFO - Online: Yes 13:02:44 INFO - Rotation: Supported 13:02:44 INFO - Return code: 0 13:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:02:44 INFO - Python 2.7.3 13:02:44 INFO - Return code: 0 13:02:44 INFO - grabbing minidump binary from tooltool 13:02:44 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')]} 13:02:44 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 0x107fd5d30>, '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 0x107d3adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107fcdb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:02:44 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 13:02:44 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 13:02:44 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 13:02:44 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:02:44 INFO - Return code: 0 13:02:44 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:02:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:02:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:02:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:02:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:02:44 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/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 13:02:44 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/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0382 --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 13:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iVq53PldDx/Render', 13:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:02:44 INFO - 'HOME': '/Users/cltbld', 13:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:02:44 INFO - 'LOGNAME': 'cltbld', 13:02:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:02:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:02:44 INFO - 'MOZ_NO_REMOTE': '1', 13:02:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:02:44 INFO - 'NO_EM_RESTART': '1', 13:02:44 INFO - 'PAGER': '/bin/cat', 13:02:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:02:44 INFO - 'PWD': '/builds/slave/test', 13:02:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:02:44 INFO - 'SHELL': '/bin/bash', 13:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rUfllImX16/Listeners', 13:02:44 INFO - 'TMPDIR': '/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/', 13:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:02:44 INFO - 'USER': 'cltbld', 13:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:02:44 INFO - 'XPC_FLAGS': '0x0', 13:02:44 INFO - 'XPC_SERVICE_NAME': '0', 13:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:02:44 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/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0382', '--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 13:02:44 INFO - mozversion application_buildid: 20160630105630 13:02:44 INFO - mozversion application_changeset: 8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc 13:02:44 INFO - mozversion application_display_name: Nightly 13:02:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:02:44 INFO - mozversion application_name: Firefox 13:02:44 INFO - mozversion application_remotingname: firefox 13:02:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:02:44 INFO - mozversion application_vendor: Mozilla 13:02:44 INFO - mozversion application_version: 50.0a1 13:02:44 INFO - mozversion platform_buildid: 20160630105630 13:02:44 INFO - mozversion platform_changeset: 8347f75bb6a0781c2ac35cc44fb347bfc8d7cefc 13:02:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:02:44 INFO - mozversion platform_version: 50.0a1 13:02:44 INFO - using testdate: 1467316964 13:02:44 INFO - actual date: 1467316964 13:02:44 INFO - starting webserver on 'localhost:58582' 13:02:44 INFO - SUITE-START | Running 2 tests 13:02:44 INFO - TEST-START | dromaeo_css 13:02:44 INFO - operating with platform_type : mac_ 13:02:44 INFO - Initialising browser for dromaeo_css test... 13:02:44 INFO - TEST-INFO | started process 2560 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpIo56Gv/profile http://localhost:58582/getInfo.html) 13:02:47 INFO - PROCESS | 2560 | __metrics Screen width/height:1600/1200 13:02:47 INFO - PROCESS | 2560 | colorDepth:24 13:02:47 INFO - PROCESS | 2560 | Browser inner width/height: 1024/689 13:02:47 INFO - PROCESS | 2560 | __metrics 13:02:48 ERROR - PROCESS | 2560 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:02:48 INFO - TEST-INFO | 2560: exit 0 13:02:48 INFO - Browser initialized. 13:02:48 INFO - Running cycle 1/1 for dromaeo_css test... 13:02:48 INFO - TEST-INFO | started process 2563 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpIo56Gv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:03:00 INFO - PROCESS | 2563 | RSS: Main: 255823872 13:03:00 INFO - PROCESS | 2563 | 13:03:50 INFO - PROCESS | 2563 | 1467317030532 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] 13:06:02 INFO - PROCESS | 2563 | Cycle 1(1): loaded http://localhost:58582/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58582/tests/dromaeo/cssquery-ext.html) 13:06:03 INFO - PROCESS | 2563 | RSS: Main: 268255232 13:06:03 INFO - PROCESS | 2563 | 13:09:05 INFO - PROCESS | 2563 | Cycle 1(1): loaded http://localhost:58582/tests/dromaeo/cssquery-ext.html (next: http://localhost:58582/tests/dromaeo/cssquery-jquery.html) 13:09:06 INFO - PROCESS | 2563 | RSS: Main: 276758528 13:09:06 INFO - PROCESS | 2563 | 13:12:08 INFO - PROCESS | 2563 | Cycle 1(1): loaded http://localhost:58582/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58582/tests/dromaeo/cssquery-mootools.html) 13:12:08 INFO - PROCESS | 2563 | RSS: Main: 281542656 13:12:08 INFO - PROCESS | 2563 | 13:15:10 INFO - PROCESS | 2563 | Cycle 1(1): loaded http://localhost:58582/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58582/tests/dromaeo/cssquery-prototype.html) 13:15:11 INFO - PROCESS | 2563 | RSS: Main: 280678400 13:15:11 INFO - PROCESS | 2563 | 13:18:14 INFO - PROCESS | 2563 | Cycle 1(1): loaded http://localhost:58582/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58582/tests/dromaeo/cssquery-yui.html) 13:18:14 INFO - PROCESS | 2563 | RSS: Main: 284180480 13:18:14 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | Cycle 1(1): loaded http://localhost:58582/tests/dromaeo/cssquery-yui.html (next: http://localhost:58582/tests/dromaeo/cssquery-dojo.html) 13:21:17 INFO - PROCESS | 2563 | RSS: Main: 284327936 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | __start_tp_report 13:21:17 INFO - PROCESS | 2563 | _x_x_mozilla_page_load 13:21:17 INFO - PROCESS | 2563 | _x_x_mozilla_page_load_details 13:21:17 INFO - PROCESS | 2563 | |i|pagename|runs| 13:21:17 INFO - PROCESS | 2563 | |0;dojo.html;3396.660333966602;3414.890160697774;3416.624171341152;3433.467812489065;3436.8486557003403;5867.4719275265215;5928.081147422151;5934.1692163097205;5935.22842030536;5942.970285148579;5699.515541178995;5876.588638795286;5894.410558944114;5935.109733539971;5943.851403714909;5255.500727430888;5323.653962492425;5389.83830485086;5406.8918621627545;5455.290812194409;138.44745323676747;5273.709945952971;5338.946610533883;5382.91925621116;5407.215953686713;5336.17289320156;5345.999999999961;5365.141577347606;5374.086405311087;5387.676739395649;5384.273123128406;5396.622236443451;5406.375037994112;5436.293281873332;5513.751881165357;5249;5294.841154765363;5335.439778823245;5356.839294821123;5412.134058550652;5788.160716696056;5892.558058145613;5942.108683697436;6033.42682445167;6042.969785151046;6168.136460895478;6263.279722831841;6306.621602703853;6307.432331090224;6339.302676705559;6255.781047663356;6286.465650419674;6333.619982801047;6341.556091073627;6362.363763623647;4990.775415106293;6007.4893634041155;6019.608725432833;6033.245844269466;6042.848928776816;6252.812415627447;6381.3937675920715;6456.031595260749;6485.4811615070685;6537.509686773511;6069.878602427927;6197;6296.874062518724;6313.273973493016;6324.1778568786685;6270.184875966095;6362.077498762654;6366.236051673829;6371.299157092716;6371.39471750183;6221.253449586078;6256.436920677161;6260.24877014752;6267.1539342189135;6322.968385158137;6320.71556779946;6322.652254126067;6324.3991820776955;6327.557071004985;6353.237611486558;5098.745062746848;5133.4096578893905;5146.4853514648985;5161.922571161435;5162.045021670928;4451.3323001550025;4490.348899409632;4494.9325760113625;4554.7039442436135;4593.104344652827;4940.456549779521;5809.9419005809405;6004.63972161663;6010.158577799111;6010.4891084258325;6273.153124328249;6274.623522588659;6314.62112273265;6319.6208227506495;6332.778352757631;6073.605215661057;6078.848028799315;6103.993220001014;6110.725017374229;6144.477719393813;5497.752601132958;5582.162675598693;5621.100623900156;5636.18275350072;5638.126090455986;6477.287498375175;6523.086767852505;6552.639604821685;6611.07444957716;6612.636305003271;5845.386234445322;6353.555251132377;6361.332060133619;6364.109024736448;6392.073149393219;6364.045393191059;6443.420092191538;6474.967625161844;6554.672266386567;6599.439047681001;6272.655003974825;6273.247210334789;6332.398422149889;6332.461740752087;6366.554341196072;6327.715252813542;6341.048842673636;6363.61818290904;6365;6366.045093236052;6121.483458747687;6189.226346706661;6227;6270.937290627217;6299.055141728594;6143.938560614337;6223.253209614875;6269.655168965751;6286.402791734778;6304.211973503312;4947.653664243612;5223.4776522347465;5242.711650859239;5423.3491980962535;6092.360302168208;6121.239585875057;6141.486007784364;6146.340488068107;6187.628742275478;6203.8138855834395;6189.226346706661;6198.2252218472695;6203.534734894991;6215.689215539114;6218.9378106218355 13:21:17 INFO - PROCESS | 2563 | |1;ext.html;471.78533767135934;475.98377464114117;488.5114885114885;523.1577160771158;523.6465385864541;30243.243918902037;30276.848615756946;40864.591354086486;41618.58381416185;41656.79171604145;41871.37192942101;42538.14923701524;42822.92942676427;43061.138777224514;43068;9536.189423898977;9713.125818676317;9721.368111072794;9739.610415583367;9767.267454940873;8275.172482751737;9067.002629710727;9645.08371704687;9651.420914745102;9671.661491847752;9646.614135434575;9678.806423871518;9735.075167859042;9741.756456088584;9764.804703905953;9505.239580833551;9570.760730981747;9686.370385924893;9691.854622180674;9695.951520242425;9523.761905952337;9549.713508594683;9559.283053770994;9634.75913102171;9736.610535578568;40069.59930400688;40133.19733605311;40517.594824051674;40635.187296254204;40843;3336.666333366644;3341.081202669285;3408.386490431721;3552.5381700379044;3883.902902427462;32477.51283730746;33036;33263.002109936744;33454.498182527284;33544;3224.871005159791;3269.869205231788;3290.7038366546885;3310.2220978070136;3409;440920;444391;446399;447051.76474117744;448604;29199.41601167965;34217.48673769896;34994.9501514955;61054.77890442255;61558.69220653868;32302.515462268086;35113;35445.468317975254;35633.46549801755;36172.63827361746;14999.325030373659;15080.698386032218;15121.848781512044;15138.470153544573;15142.54572362831;12747.936260318824;12812.42344094518;12826.294553799631;12833.935830320788;12878.613641590768;7818.3354414875375;7824.882626760603;7829.177936316719;7837.981062461843;7921.683132674743;3233.8383080845865;3246.788958717676;3258.25060236147;3288.095773662262;3308.93382132356;929.772205809581;937.5265490927175;945.8675785390051;978.8189185000798;1153.429052618959;28951.192110847584;30868.228294292374;31058;31338.529922051188;31726.36547269088;1061.994690026545;1131.7000994736402;1171.9589814356457;1193.797054500737;1222.7554489102215;15448.609625133791;15984.440544580884;15999.840001600069;16592.83407165937;16719.247633856507;683270;692344;699497;700855;702035;50876.745616271684;55520;60855.39144608497;61509.69245153835;61565;1234.975300493985;1334.873187047229;1368.6509939965445;1370.6847425092285;1407.7536431124513;27275.181744547695;30502.69497305087;30538.541921871634;30675.539866901567;31242.687573123978;45612.85967850831;47509.762451187526;48684.269735954695;49105.75447122742;51985.48014519807;505099.4745026251;595688;598330;599476;601192;26772.59841102424;27464.450710986068;27639.447211055263;27753.722462775113;27939.62513186402;40405.595944040186;49093;49196;50022.49977500324;50277.74861125671;40598.59401405948;40614.79692601518;41061.38407923824;41072.1785564293;41115.355385784234;40146.39780403355;40201;40651.59348406478;41507.584924150375;41698.74903752892;39242.80378598089;39376.40935386029;40180.39729404003;40363.3945490812;41981.580184197766;32756.34487310288;35026.474602881484;35613.287734245685;35651.28697426089;35894.461583076794;23193.652095218247;26332.21003369902;26519.806608702267;26674.12925466626;26696.599551006362 13:21:17 INFO - PROCESS | 2563 | |2;jquery.html;369.3499440983868;372.5529364762284;376.363944933063;382.69766884161515;395.89310886060764;19505.219791208354;20537.38387848365;20681.379558613247;21013.684794728055;21346.786532134673;20190.89904550479;20271.59456810863;20657.896710516427;21064.89467552664;21704;5607.579431542651;5963.135345374918;6136.048912418582;6177.938220617782;6191.257049154108;5997.940020599804;6041.124037014631;6102.542309326796;6117.785877494289;6119.26568811741;5863.912041319383;5923.703814809264;5952.285725712921;5974.372690867462;5976.641401515923;5888.5877988540815;5996.940030599681;6053.909191362133;6054.33402325746;6058.212432383806;5197.324347834758;5222.712750798704;5226.843194704165;5230.372355317349;5232.790688372461;25325.240242792745;25865;25944.221673349828;26029;26045.348866278306;2252.5494901019697;2487.614419764939;2696.595510673395;2790.0234917778816;2830.5188118019987;15448.382064717398;16003.519894403187;16084.517464475968;16227.83772162275;16343.42798002076;1871.2421469304954;1872.3166044393697;1874.1097978460123;1891.366392258595;1933.2556965568217;92449;93115;110048;112958.87041129566;115297;10078.740157480315;11189.328640281608;11685.474153663106;11830.526778928746;11832.17174797773;14500.492482763053;14696.897732669879;14747.262636868114;14765.114093154445;14772.48296309624;7155.747744144754;8602.612882420306;8703.825923481621;8742.213200811957;8850.159234872677;8675.436096653697;8698.956505217433;8760.386772925835;8854.468731876108;8893.333000025024;4513.977430112828;4555.293929440942;4578.9542104579195;4594.748573199176;4625.514320996314;1644.597073716947;1933.3233368321257;1968.153693911603;1968.7498438491662;1971.684530475117;884.8893888263967;932.7434955387323;953.2897990996752;970.8301047316692;985.261054209343;20280.79719202789;21036.789632103788;21383.35849924505;21427.67858482124;21583.892080539496;791.705561407092;872.5986046418592;924.5885580916428;954.71358592422;977.6675930183629;10972.725681858017;11538.826917596243;11555.595554155565;11652.94173529127;11680.88319116815;639134;643511;646771;647562.3653292067;647732.7613361997;95375.046249538;124310;134415;143511.2824435892;148742;960.2462067277154;969.1519920069939;997.6258902911263;999.5901680311038;1004.4927311707687;18569.16438760232;19246.615067698287;19316.613667726284;19785.901070494554;19859.205631774566;56858.7157064212;59933.101003485855;59978.701171434244;60869.69565152146;61218.693906530185;85893.28213435822;86109.56945215484;86223;86304.70542941986;88255;6975.197852247056;7508.324250817453;7548.811279718051;7852.214778522102;8296.585170741559;12153.69615759613;13360.331983400985;13512.121712089076;13555.457781689016;13670.93164534171;11646.301221926711;11782.234154779911;11813.291202527877;11839.881601183877;11980.76038479243;11104.833427498756;11500.252483588874;11563.190576659554;11743.001844843284;11852.881471185523;11592.884071159518;11633.6509904703;11915.642530723746;11966.820497692715;12099.637010889688;7644.426667999811;7674.6930122794465;7681.231876812274;7705.653245603849;7801.2198780121535;11412.714682133013;11607.245529040585;11715.17993740464;11812;11926.045916326499 13:21:17 INFO - PROCESS | 2563 | |3;mootools.html;1502.872255858252;1540.0759544273433;1683.461292386436;1724.6550689862022;1725.8533024692902;7999.800004999864;8559.058503564604;8573.271271941885;9078.818423631523;9103.726888193356;8676.652933882637;8719.694810681627;8815.603297851596;8836.602352894119;8840.690575829847;2347.3192774095533;2363.326451961191;2367.206985659806;2370.419247284418;2379.7977171940406;2314.5602335556273;2337.0301324950124;2344.038944032947;2351.2828587280874;2351.8000969917575;2356.1871154451774;2367.8934447949796;2377.7146742390937;2383.261189031397;2387.761223877607;2348.4011577047913;2366.9644955325684;2372.0274687378264;2374.7387787343378;2376.5128148729555;2355.9057637694473;2365.680633114525;2368.4552552912755;2369.7037870266217;2383.809295256375;8868.600912958867;8909.821803563957;8993.820123597558;9024.819503609891;9036.096390360912;5317.707526086064;5467.6719396836315;5476.2333273341765;5477.178423236506;5498.230247765316;3471.9826400868087;3482.181687303482;3622.6196249393697;3680.429533422324;3686.686631636314;1089.2701889733896;1090.6782499162766;1099.164634877491;1099.3074363151243;1114.3703807348822;11537.365444900528;11648.534058637644;11744.530218791238;11768.58809941648;11795.29228246308;3751.5873253942045;4232.30167022444;4282.614564689193;4371.9944412785235;4451;7776.144624091458;8040.316573091352;9008.234300084436;9206.17144457002;9223.354365194373;5277.287566178594;5277.498637629419;5283;5285.814996475105;5291.126964050965;4462.732236065846;4761.40482439695;4923.75381230937;4927.482614325444;4951.96008838148;3180.8866896586474;3834.884953451401;3860.1700634363747;3873.6055020192707;3936.075022369741;1156.3235507228367;1158.1198289300191;1162.9008691836161;1167.9941600291945;1174.5008371442275;900.2977677411629;908.5956749246521;923.2752289452748;945.385499425379;965.4255717847869;5892.204552385459;6025.307089684655;6063.787767428119;6101.603395779349;6288.245410550763;414.7138474452618;425.52978958251305;432.47022397562733;433.9978300108479;437.47502996404444;4020.5175378954127;4092.07928216149;4093.201825643971;4147.880072380441;4156.958430415718;9097;10493.370397776158;10997.505112269968;11013.118950483942;11030;10759.78480430387;10843.566257349617;10899.455027248607;10927.235093543535;11022.118230541537;6929.341712537301;8239.670413183405;8297.668093276323;8353.457025293337;8375;6087.665178415053;6132.78535251264;6184.474319682878;6252.468540174136;6271.341509141657;8836.646534138563;10094.495275236355;10280.280380373302;10353.171746260432;10366.844497332395;8841.911580884109;10098.091171794575;10247.180225582084;10378.584856605652;10771.19216058783;7073.858522829411;7429.517081389692;7582.090149182133;7639.388848892187;7681.231876812274;7044.189918159477;8539.060703322753;8602.096779838026;8613.82772344537;8622.61198246068;7504;7672.232776722283;7704.075510938499;7720.227977202235;7749;7507.099148102263;7544.4341674373545;7584.393248539993;7688.692452302069;7726.652300646597;7207.207207207098;7248.891266630899;7250;7261.237570055068;7273.309035641606;4956.975215123901;5091.287219789307;5092.949070509248;5163.767630456714;5171.922421163761;5175.275461435477;5221.112410890234;5226.477352264743;5248.448912864094;5337 13:21:17 INFO - PROCESS | 2563 | |4;prototype.html;290.77900795395493;303.951367781155;306.54018971542683;306.6611394409179;309.1637121586109;4532.798808315791;5416.050221920115;5639.66162030278;5675.631083979543;5749.367569567345;4561.977190114053;5300.973495132529;5660.745266463009;5662.716864156786;5668.412844403563;3454.7236221102376;3762.6425489578446;4309.935350969738;4312.757366169598;4321.783910804463;3099.5660607514965;4277.25148099083;4322.308430651096;4332.328489084197;4335.176316499871;3889.6499315061637;4175.624193822556;4194.832206711743;4216.9578304216875;4222.387753775701;3477.5479187705437;3820.9808950955344;3822.4648549203134;3859.9228015439817;4240.618344348993;3649.2701459708164;3654.83045425464;3662.011256960606;3664.4136938089778;3676;4625.121226966866;4817.325574419584;5114.105031619451;5140.357455318085;5546.91679624806;3950.4074388841905;4716.622670186377;4793.952060479421;4803.615710743132;4828.5412885775795;5733.283339582552;5890.558208134365;5892.440218179266;5930.021546444831;5943.64338139713;3550.467429885538;3702.2780557791243;3759.3233218020746;3976.741511801724;3979.6617287530594;5407.783688652449;6211.658358790265;6232.657203853786;6283.05754136874;6321.431071203614;4013.4180543821567;4025.054112283611;4032.0121570215483;4033.3748269018347;4043.433919251307;3867.5165604299464;4071.97964010184;4080.4083407905687;4083.285425050664;4098.569650186688;4377;4723.7401942893475;4741.5021422750115;4778.665493415428;4805.303231031481;5680.573956953245;5898.8820223595285;5912.575843903979;5960.37416071315;6014.3761184479945;1350.4463170100212;1385.0235583913318;1385.6051025457696;1387.2797730813718;1387.4380875745137;752.6527515746861;820.6389188757047;821.6894053983887;848.0544193224633;854.1629203380597;4298.5384969110655;4480.857381367796;4486.3494793254795;4656.837010704677;4692.554207350297;4195.937060944088;4563.338315944236;4750.501197374226;4825.710457372569;5177.689338639693;3976.840926362971;4301.11827075455;4384.649228061748;4613.3324007414185;4666.510016448224;2285.7656865292556;2722.992492777685;2726.8091233613854;2728.2770065932546;2745.7391547802927;4366.890827729332;5350.571954243651;5351.411344752152;5372.006178856924;5377.902617978992;4678.228092364721;4959.032988567267;5169.836786723033;5257.579393648499;5268.762905669254;5113.346854362587;5331.640431689972;5332.120200166929;5343.62594618373;5373.167159090347;4608.930866036945;4616.960159860122;4987.476314986874;5086.745662716923;5105.285260063668;4175.081482073939;4713.3401323814005;4750.501197374226;5030.647854650139;5068.239764035424;4540.796688877384;4551.175753701087;5013.896942672606;5015.724135172601;5237;3217.324361883937;3527.876524321636;3530.3998320286128;3530.7579686899517;3535.5934067582557;4133.731307465006;4206.621404073648;5047.61190672568;5104.213525266276;5528.77530733453;5399.70301633414;5893.202573215211;5909.852253693692;5931.792387266598;6000.669963152069;5895.4399332063385;5905.379935106924;5915.2310199675485;5938.96068188074;5976.223090998143;4894.751838281216;5031.572316353151;5444.339476459718;5489.917651235314;5696.060150075191;5635.9436405635415;5832.24180856486;5888.4700376966275;5920.37836027211;5949.3753155918;4657.69724967876;4929.605631549539;5317.813876514303;5637.406792875159;5802.361740208489 13:21:17 INFO - PROCESS | 2563 | |5;yui.html;691.7751730687525;698.6262349642941;727.3744579661491;728.5919884864476;745.817274767682;15165.772513412294;15298.464553740621;15386.769198462032;15646.608834779136;15689.52931412058;14207.934404919646;14212.71574568508;14310.642233944156;14318.64203394913;14331.570052898403;679.7450955891541;816.6692489541745;838.4591938199858;841.8105926166625;842.2419822160043;841.1798496465958;871.4509858788954;872.380609767063;872.415481627308;872.8647059705755;817.5544328341039;854.444611002847;903.0472851142042;913.684778751333;914.9359544831865;793.5042444991204;818.9181081891822;876.4084243135858;890.9109089091104;906.60109551797;651.4072194303161;663.2207156591035;665.3712241931377;674.8886433738427;677.2820809941428;15325.23373831304;15461.304241309055;15482.071075735492;15485.303161357766;15492.147931863743;11956.641300760992;14904.925475372662;14936.70126597462;15041.548753537412;15049.398024079024;10553.47232638365;11917.940410297893;11923.284602923852;12216.694582635417;12461.875381246162;3894.5131858517684;3938.822752976123;4021.718479706422;4060.4315395844606;4067.5118985721606;111329;112294.43852780765;116700.83299166984;117607;119753.99999999913;11439;11538.289708167193;11658.009069229041;11728.413579321;11793.882061179278;22547.774522254895;23068.884655576614;23989.640155397683;24054;24187.395315117265;7856.292933636;7909.288164065147;8219.630116644765;8250.174982501701;8481.982162140459;4664.113818374498;4670.229412147026;4709.222978208626;4763;4842.249451335048;3602.873899413508;3633.3459977204357;3638.235970446236;3710.8330125144435;3729.4405839123806;659.3208994735335;676.2594958520413;676.9763058292937;680.877442060424;692.3457332820436;570.0508653092637;624.3506752976854;662.2450406536552;673.4309508465338;685.951844794738;9312.534373281309;9509.610988530429;9515;9653.758656033655;9698.903010969942;560.9242752228479;645.0099097884818;662.9767958121442;673.6328700858044;675.3685304240453;4442.711223770445;4649.349091127245;4706;5144.202648589475;5207.3490813648295;139719.30140349234;164549;167520;169278;174073;101870;102508.48745756224;118191;132553;133398.33300833433;116649;116806;118933.40533297451;119143.48993355573;120488.39755801165;9390.530473476436;9906.851397228904;9922.702318930444;9931.255155863195;10203.591856325664;56430.7178464105;56757.14864276956;61408;61537.69231153816;63185.052224217594;82226.17773822186;84656.57671711603;89424.5528772378;98473.50763246138;98926.51610225708;13405;13409.463621455423;13482.123661961941;13484.234762934571;13591.79612305836;15279;15317.693646127238;15414.075155490706;15848.366065357257;16036.518904432885;14195.219262940638;14313.856861431252;14357.066790658992;14410.927945360207;14769.852301477278;14125.576232713034;14177.787333189804;14210;14239.715205696035;14721.484748033767;12440.75118497643;12613.621591352274;12639.115261931944;13507.122037067558;14123.072776549194;10314.381137131797;11150.498227579941;11366.886331136582;11618.186726929034;11889.108316876096;10340.896591033994;11080.156329921674;11290.717732056764;11793.41032948332;11797.52809887595 13:21:17 INFO - PROCESS | 2563 | __end_tp_report 13:21:17 INFO - PROCESS | 2563 | __start_cc_report 13:21:17 INFO - PROCESS | 2563 | _x_x_mozilla_cycle_collect,449 13:21:17 INFO - PROCESS | 2563 | __end_cc_report 13:21:17 INFO - PROCESS | 2563 | __startTimestamp1467318077908__endTimestamp 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | ------- Summary: start ------- 13:21:17 INFO - PROCESS | 2563 | Number of tests: 6 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | [#0] dojo.html Cycles:165 Average:5835.39 Median:6121.48 stddev:792.65 (12.9%) stddev-sans-first:771.65 13:21:17 INFO - PROCESS | 2563 | Values: 3396.7 3414.9 3416.6 3433.5 3436.8 5867.5 5928.1 5934.2 5935.2 5943.0 5699.5 5876.6 5894.4 5935.1 5943.9 5255.5 5323.7 5389.8 5406.9 5455.3 138.4 5273.7 5338.9 5382.9 5407.2 5336.2 5346.0 5365.1 5374.1 5387.7 5384.3 5396.6 5406.4 5436.3 5513.8 5249.0 5294.8 5335.4 5356.8 5412.1 5788.2 5892.6 5942.1 6033.4 6043.0 6168.1 6263.3 6306.6 6307.4 6339.3 6255.8 6286.5 6333.6 6341.6 6362.4 4990.8 6007.5 6019.6 6033.2 6042.8 6252.8 6381.4 6456.0 6485.5 6537.5 6069.9 6197.0 6296.9 6313.3 6324.2 6270.2 6362.1 6366.2 6371.3 6371.4 6221.3 6256.4 6260.2 6267.2 6323.0 6320.7 6322.7 6324.4 6327.6 6353.2 5098.7 5133.4 5146.5 5161.9 5162.0 4451.3 4490.3 4494.9 4554.7 4593.1 4940.5 5809.9 6004.6 6010.2 6010.5 6273.2 6274.6 6314.6 6319.6 6332.8 6073.6 6078.8 6104.0 6110.7 6144.5 5497.8 5582.2 5621.1 5636.2 5638.1 6477.3 6523.1 6552.6 6611.1 6612.6 5845.4 6353.6 6361.3 6364.1 6392.1 6364.0 6443.4 6475.0 6554.7 6599.4 6272.7 6273.2 6332.4 6332.5 6366.6 6327.7 6341.0 6363.6 6365.0 6366.0 6121.5 6189.2 6227.0 6270.9 6299.1 6143.9 6223.3 6269.7 6286.4 6304.2 4947.7 5223.5 5242.7 5423.3 6092.4 6121.2 6141.5 6146.3 6187.6 6203.8 6189.2 6198.2 6203.5 6215.7 6218.9 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | [#1] ext.html Cycles:180 Average:69246.31 Median:40558.09 stddev:156386.66 (385.6%) stddev-sans-first:156740.11 13:21:17 INFO - PROCESS | 2563 | Values: 471.8 476.0 488.5 523.2 523.6 30243.2 30276.8 40864.6 41618.6 41656.8 41871.4 42538.1 42822.9 43061.1 43068.0 9536.2 9713.1 9721.4 9739.6 9767.3 8275.2 9067.0 9645.1 9651.4 9671.7 9646.6 9678.8 9735.1 9741.8 9764.8 9505.2 9570.8 9686.4 9691.9 9696.0 9523.8 9549.7 9559.3 9634.8 9736.6 40069.6 40133.2 40517.6 40635.2 40843.0 3336.7 3341.1 3408.4 3552.5 3883.9 32477.5 33036.0 33263.0 33454.5 33544.0 3224.9 3269.9 3290.7 3310.2 3409.0 440920.0 444391.0 446399.0 447051.8 448604.0 29199.4 34217.5 34995.0 61054.8 61558.7 32302.5 35113.0 35445.5 35633.5 36172.6 14999.3 15080.7 15121.8 15138.5 15142.5 12747.9 12812.4 12826.3 12833.9 12878.6 7818.3 7824.9 7829.2 7838.0 7921.7 3233.8 3246.8 3258.3 3288.1 3308.9 929.8 937.5 945.9 978.8 1153.4 28951.2 30868.2 31058.0 31338.5 31726.4 1062.0 1131.7 1172.0 1193.8 1222.8 15448.6 15984.4 15999.8 16592.8 16719.2 683270.0 692344.0 699497.0 700855.0 702035.0 50876.7 55520.0 60855.4 61509.7 61565.0 1235.0 1334.9 1368.7 1370.7 1407.8 27275.2 30502.7 30538.5 30675.5 31242.7 45612.9 47509.8 48684.3 49105.8 51985.5 505099.5 595688.0 598330.0 599476.0 601192.0 26772.6 27464.5 27639.4 27753.7 27939.6 40405.6 49093.0 49196.0 50022.5 50277.7 40598.6 40614.8 41061.4 41072.2 41115.4 40146.4 40201.0 40651.6 41507.6 41698.7 39242.8 39376.4 40180.4 40363.4 41981.6 32756.3 35026.5 35613.3 35651.3 35894.5 23193.7 26332.2 26519.8 26674.1 26696.6 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | [#2] jquery.html Cycles:180 Average:36741.56 Median:2743.31 stddev:107128.21 (3905.1%) stddev-sans-first:107393.92 13:21:17 INFO - PROCESS | 2563 | Values: 369.3 372.6 376.4 382.7 395.9 19505.2 20537.4 20681.4 21013.7 21346.8 20190.9 20271.6 20657.9 21064.9 21704.0 5607.6 5963.1 6136.0 6177.9 6191.3 5997.9 6041.1 6102.5 6117.8 6119.3 5863.9 5923.7 5952.3 5974.4 5976.6 5888.6 5996.9 6053.9 6054.3 6058.2 5197.3 5222.7 5226.8 5230.4 5232.8 25325.2 25865.0 25944.2 26029.0 26045.3 2252.5 2487.6 2696.6 2790.0 2830.5 15448.4 16003.5 16084.5 16227.8 16343.4 1871.2 1872.3 1874.1 1891.4 1933.3 92449.0 93115.0 110048.0 112958.9 115297.0 10078.7 11189.3 11685.5 11830.5 11832.2 14500.5 14696.9 14747.3 14765.1 14772.5 7155.7 8602.6 8703.8 8742.2 8850.2 8675.4 8699.0 8760.4 8854.5 8893.3 4514.0 4555.3 4579.0 4594.7 4625.5 1644.6 1933.3 1968.2 1968.7 1971.7 884.9 932.7 953.3 970.8 985.3 20280.8 21036.8 21383.4 21427.7 21583.9 791.7 872.6 924.6 954.7 977.7 10972.7 11538.8 11555.6 11652.9 11680.9 639134.0 643511.0 646771.0 647562.4 647732.8 95375.0 124310.0 134415.0 143511.3 148742.0 960.2 969.2 997.6 999.6 1004.5 18569.2 19246.6 19316.6 19785.9 19859.2 56858.7 59933.1 59978.7 60869.7 61218.7 85893.3 86109.6 86223.0 86304.7 88255.0 6975.2 7508.3 7548.8 7852.2 8296.6 12153.7 13360.3 13512.1 13555.5 13670.9 11646.3 11782.2 11813.3 11839.9 11980.8 11104.8 11500.3 11563.2 11743.0 11852.9 11592.9 11633.7 11915.6 11966.8 12099.6 7644.4 7674.7 7681.2 7705.7 7801.2 11412.7 11607.2 11715.2 11812.0 11926.0 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | [#3] mootools.html Cycles:180 Average:5705.86 Median:4939.72 stddev:3210.32 (65.0%) stddev-sans-first:3203.78 13:21:17 INFO - PROCESS | 2563 | Values: 1502.9 1540.1 1683.5 1724.7 1725.9 7999.8 8559.1 8573.3 9078.8 9103.7 8676.7 8719.7 8815.6 8836.6 8840.7 2347.3 2363.3 2367.2 2370.4 2379.8 2314.6 2337.0 2344.0 2351.3 2351.8 2356.2 2367.9 2377.7 2383.3 2387.8 2348.4 2367.0 2372.0 2374.7 2376.5 2355.9 2365.7 2368.5 2369.7 2383.8 8868.6 8909.8 8993.8 9024.8 9036.1 5317.7 5467.7 5476.2 5477.2 5498.2 3472.0 3482.2 3622.6 3680.4 3686.7 1089.3 1090.7 1099.2 1099.3 1114.4 11537.4 11648.5 11744.5 11768.6 11795.3 3751.6 4232.3 4282.6 4372.0 4451.0 7776.1 8040.3 9008.2 9206.2 9223.4 5277.3 5277.5 5283.0 5285.8 5291.1 4462.7 4761.4 4923.8 4927.5 4952.0 3180.9 3834.9 3860.2 3873.6 3936.1 1156.3 1158.1 1162.9 1168.0 1174.5 900.3 908.6 923.3 945.4 965.4 5892.2 6025.3 6063.8 6101.6 6288.2 414.7 425.5 432.5 434.0 437.5 4020.5 4092.1 4093.2 4147.9 4157.0 9097.0 10493.4 10997.5 11013.1 11030.0 10759.8 10843.6 10899.5 10927.2 11022.1 6929.3 8239.7 8297.7 8353.5 8375.0 6087.7 6132.8 6184.5 6252.5 6271.3 8836.6 10094.5 10280.3 10353.2 10366.8 8841.9 10098.1 10247.2 10378.6 10771.2 7073.9 7429.5 7582.1 7639.4 7681.2 7044.2 8539.1 8602.1 8613.8 8622.6 7504.0 7672.2 7704.1 7720.2 7749.0 7507.1 7544.4 7584.4 7688.7 7726.7 7207.2 7248.9 7250.0 7261.2 7273.3 4957.0 5091.3 5092.9 5163.8 5171.9 5175.3 5221.1 5226.5 5248.4 5337.0 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | [#4] prototype.html Cycles:180 Average:4440.08 Median:4746.00 stddev:1372.77 (28.9%) stddev-sans-first:1340.83 13:21:17 INFO - PROCESS | 2563 | Values: 290.8 304.0 306.5 306.7 309.2 4532.8 5416.1 5639.7 5675.6 5749.4 4562.0 5301.0 5660.7 5662.7 5668.4 3454.7 3762.6 4309.9 4312.8 4321.8 3099.6 4277.3 4322.3 4332.3 4335.2 3889.6 4175.6 4194.8 4217.0 4222.4 3477.5 3821.0 3822.5 3859.9 4240.6 3649.3 3654.8 3662.0 3664.4 3676.0 4625.1 4817.3 5114.1 5140.4 5546.9 3950.4 4716.6 4794.0 4803.6 4828.5 5733.3 5890.6 5892.4 5930.0 5943.6 3550.5 3702.3 3759.3 3976.7 3979.7 5407.8 6211.7 6232.7 6283.1 6321.4 4013.4 4025.1 4032.0 4033.4 4043.4 3867.5 4072.0 4080.4 4083.3 4098.6 4377.0 4723.7 4741.5 4778.7 4805.3 5680.6 5898.9 5912.6 5960.4 6014.4 1350.4 1385.0 1385.6 1387.3 1387.4 752.7 820.6 821.7 848.1 854.2 4298.5 4480.9 4486.3 4656.8 4692.6 4195.9 4563.3 4750.5 4825.7 5177.7 3976.8 4301.1 4384.6 4613.3 4666.5 2285.8 2723.0 2726.8 2728.3 2745.7 4366.9 5350.6 5351.4 5372.0 5377.9 4678.2 4959.0 5169.8 5257.6 5268.8 5113.3 5331.6 5332.1 5343.6 5373.2 4608.9 4617.0 4987.5 5086.7 5105.3 4175.1 4713.3 4750.5 5030.6 5068.2 4540.8 4551.2 5013.9 5015.7 5237.0 3217.3 3527.9 3530.4 3530.8 3535.6 4133.7 4206.6 5047.6 5104.2 5528.8 5399.7 5893.2 5909.9 5931.8 6000.7 5895.4 5905.4 5915.2 5939.0 5976.2 4894.8 5031.6 5444.3 5489.9 5696.1 5635.9 5832.2 5888.5 5920.4 5949.4 4657.7 4929.6 5317.8 5637.4 5802.4 13:21:17 INFO - PROCESS | 2563 | 13:21:17 INFO - PROCESS | 2563 | [#5] yui.html Cycles:180 Average:25464.28 Median:13895.13 stddev:40937.01 (294.6%) stddev-sans-first:41009.60 13:21:17 INFO - PROCESS | 2563 | Values: 691.8 698.6 727.4 728.6 745.8 15165.8 15298.5 15386.8 15646.6 15689.5 14207.9 14212.7 14310.6 14318.6 14331.6 679.7 816.7 838.5 841.8 842.2 841.2 871.5 872.4 872.4 872.9 817.6 854.4 903.0 913.7 914.9 793.5 818.9 876.4 890.9 906.6 651.4 663.2 665.4 674.9 677.3 15325.2 15461.3 15482.1 15485.3 15492.1 11956.6 14904.9 14936.7 15041.5 15049.4 10553.5 11917.9 11923.3 12216.7 12461.9 3894.5 3938.8 4021.7 4060.4 4067.5 111329.0 112294.4 116700.8 117607.0 119754.0 11439.0 11538.3 11658.0 11728.4 11793.9 22547.8 23068.9 23989.6 24054.0 24187.4 7856.3 7909.3 8219.6 8250.2 8482.0 4664.1 4670.2 4709.2 4763.0 4842.2 3602.9 3633.3 3638.2 3710.8 3729.4 659.3 676.3 677.0 680.9 692.3 570.1 624.4 662.2 673.4 686.0 9312.5 9509.6 9515.0 9653.8 9698.9 560.9 645.0 663.0 673.6 675.4 4442.7 4649.3 4706.0 5144.2 5207.3 139719.3 164549.0 167520.0 169278.0 174073.0 101870.0 102508.5 118191.0 132553.0 133398.3 116649.0 116806.0 118933.4 119143.5 120488.4 9390.5 9906.9 9922.7 9931.3 10203.6 56430.7 56757.1 61408.0 61537.7 63185.1 82226.2 84656.6 89424.6 98473.5 98926.5 13405.0 13409.5 13482.1 13484.2 13591.8 15279.0 15317.7 15414.1 15848.4 16036.5 14195.2 14313.9 14357.1 14410.9 14769.9 14125.6 14177.8 14210.0 14239.7 14721.5 12440.8 12613.6 12639.1 13507.1 14123.1 10314.4 11150.5 11366.9 11618.2 11889.1 10340.9 11080.2 11290.7 11793.4 11797.5 13:21:17 INFO - PROCESS | 2563 | -------- Summary: end -------- 13:21:17 INFO - PROCESS | 2563 | 13:21:18 INFO - TEST-INFO | 2563: exit 0 13:21:18 INFO - TEST-OK | dromaeo_css | took 1113761ms 13:21:18 INFO - TEST-START | kraken 13:21:18 INFO - operating with platform_type : mac_ 13:21:18 INFO - Initialising browser for kraken test... 13:21:18 INFO - TEST-INFO | started process 2632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpysTdIw/profile http://localhost:58582/getInfo.html) 13:21:21 INFO - PROCESS | 2632 | __metrics Screen width/height:1600/1200 13:21:21 INFO - PROCESS | 2632 | colorDepth:24 13:21:21 INFO - PROCESS | 2632 | Browser inner width/height: 1024/689 13:21:21 INFO - PROCESS | 2632 | __metrics 13:21:21 ERROR - PROCESS | 2632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 13:21:22 INFO - TEST-INFO | 2632: exit 0 13:21:22 INFO - Browser initialized. 13:21:22 INFO - Running cycle 1/1 for kraken test... 13:21:22 INFO - TEST-INFO | started process 2634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/T/tmpysTdIw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:21:34 INFO - PROCESS | 2634 | RSS: Main: 255410176 13:21:34 INFO - PROCESS | 2634 | 13:21:36 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58582/tests/kraken/driver.html?testName=audio-beat-detection) 13:21:37 INFO - PROCESS | 2634 | RSS: Main: 268386304 13:21:37 INFO - PROCESS | 2634 | 13:21:40 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58582/tests/kraken/driver.html?testName=audio-dft) 13:21:40 INFO - PROCESS | 2634 | RSS: Main: 272510976 13:21:40 INFO - PROCESS | 2634 | 13:21:44 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58582/tests/kraken/driver.html?testName=audio-fft) 13:21:44 INFO - PROCESS | 2634 | RSS: Main: 272801792 13:21:44 INFO - PROCESS | 2634 | 13:21:46 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58582/tests/kraken/driver.html?testName=audio-oscillator) 13:21:47 INFO - PROCESS | 2634 | RSS: Main: 273702912 13:21:47 INFO - PROCESS | 2634 | 13:21:49 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58582/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:21:50 INFO - PROCESS | 2634 | RSS: Main: 274374656 13:21:50 INFO - PROCESS | 2634 | 13:21:53 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58582/tests/kraken/driver.html?testName=imaging-darkroom) 13:21:53 INFO - PROCESS | 2634 | RSS: Main: 274206720 13:21:53 INFO - PROCESS | 2634 | 13:21:56 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58582/tests/kraken/driver.html?testName=imaging-desaturate) 13:21:57 INFO - PROCESS | 2634 | RSS: Main: 275148800 13:21:57 INFO - PROCESS | 2634 | 13:22:00 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58582/tests/kraken/driver.html?testName=json-parse-financial) 13:22:00 INFO - PROCESS | 2634 | RSS: Main: 275329024 13:22:00 INFO - PROCESS | 2634 | 13:22:02 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58582/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:22:03 INFO - PROCESS | 2634 | RSS: Main: 275185664 13:22:03 INFO - PROCESS | 2634 | 13:22:04 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:22:05 INFO - PROCESS | 2634 | RSS: Main: 275132416 13:22:05 INFO - PROCESS | 2634 | 13:22:07 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:22:08 INFO - PROCESS | 2634 | RSS: Main: 275152896 13:22:08 INFO - PROCESS | 2634 | 13:22:11 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:22:12 INFO - PROCESS | 2634 | RSS: Main: 275255296 13:22:12 INFO - PROCESS | 2634 | 13:22:14 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:22:15 INFO - PROCESS | 2634 | RSS: Main: 275263488 13:22:15 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | Cycle 1(1): loaded http://localhost:58582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58582/tests/kraken/driver.html?testName=ai-astar) 13:22:17 INFO - PROCESS | 2634 | RSS: Main: 276066304 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | __start_tp_report 13:22:17 INFO - PROCESS | 2634 | _x_x_mozilla_page_load 13:22:17 INFO - PROCESS | 2634 | _x_x_mozilla_page_load_details 13:22:17 INFO - PROCESS | 2634 | |i|pagename|runs| 13:22:17 INFO - PROCESS | 2634 | |0;ai-astar;103;115;105;115;117;118;112;114;116;114 13:22:17 INFO - PROCESS | 2634 | |1;audio-beat-detection;147;110;130;154;107;131;130;114;155;138 13:22:17 INFO - PROCESS | 2634 | |2;audio-dft;202;200;196;212;228;205;196;201;202;201 13:22:17 INFO - PROCESS | 2634 | |3;audio-fft;73;85;99;134;58;69;57;62;130;59 13:22:17 INFO - PROCESS | 2634 | |4;audio-oscillator;71;75;122;83;105;115;114;73;71;118 13:22:17 INFO - PROCESS | 2634 | |5;imaging-gaussian-blur;110;85;135;132;90;87;93;88;90;89 13:22:17 INFO - PROCESS | 2634 | |6;imaging-darkroom;95;95;96;109;131;96;97;127;148;96 13:22:17 INFO - PROCESS | 2634 | |7;imaging-desaturate;90;93;96;98;94;89;90;92;93;89 13:22:17 INFO - PROCESS | 2634 | |8;json-parse-financial;57;56;55;57;57;55;56;58;57;57 13:22:17 INFO - PROCESS | 2634 | |9;json-stringify-tinderbox;68;70;79;72;82;76;77;76;97;72 13:22:17 INFO - PROCESS | 2634 | |10;stanford-crypto-aes;85;108;105;81;84;83;83;82;86;82 13:22:17 INFO - PROCESS | 2634 | |11;stanford-crypto-ccm;140;137;151;153;134;151;131;123;189;141 13:22:17 INFO - PROCESS | 2634 | |12;stanford-crypto-pbkdf2;163;182;148;161;179;223;226;175;154;162 13:22:17 INFO - PROCESS | 2634 | |13;stanford-crypto-sha256-iterative;59;67;65;65;68;65;68;64;66;68 13:22:17 INFO - PROCESS | 2634 | __end_tp_report 13:22:17 INFO - PROCESS | 2634 | __start_cc_report 13:22:17 INFO - PROCESS | 2634 | _x_x_mozilla_cycle_collect,1117 13:22:17 INFO - PROCESS | 2634 | __end_cc_report 13:22:17 INFO - PROCESS | 2634 | __startTimestamp1467318137580__endTimestamp 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | ------- Summary: start ------- 13:22:17 INFO - PROCESS | 2634 | Number of tests: 14 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#0] ai-astar Cycles:10 Average:112.90 Median:115.00 stddev:5.00 (4.3%) stddev-sans-first:3.81 13:22:17 INFO - PROCESS | 2634 | Values: 103.0 115.0 105.0 115.0 117.0 118.0 112.0 114.0 116.0 114.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:134.50 stddev:17.37 (12.9%) stddev-sans-first:17.50 13:22:17 INFO - PROCESS | 2634 | Values: 147.0 110.0 130.0 154.0 107.0 131.0 130.0 114.0 155.0 138.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#2] audio-dft Cycles:10 Average:204.30 Median:202.00 stddev:9.49 (4.7%) stddev-sans-first:10.03 13:22:17 INFO - PROCESS | 2634 | Values: 202.0 200.0 196.0 212.0 228.0 205.0 196.0 201.0 202.0 201.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#3] audio-fft Cycles:10 Average:82.60 Median:65.50 stddev:29.22 (44.6%) stddev-sans-first:30.78 13:22:17 INFO - PROCESS | 2634 | Values: 73.0 85.0 99.0 134.0 58.0 69.0 57.0 62.0 130.0 59.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:71.00 stddev:21.85 (30.8%) stddev-sans-first:21.43 13:22:17 INFO - PROCESS | 2634 | Values: 71.0 75.0 122.0 83.0 105.0 115.0 114.0 73.0 71.0 118.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#5] imaging-gaussian-blur Cycles:10 Average:99.90 Median:88.50 stddev:19.02 (21.5%) stddev-sans-first:19.82 13:22:17 INFO - PROCESS | 2634 | Values: 110.0 85.0 135.0 132.0 90.0 87.0 93.0 88.0 90.0 89.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#6] imaging-darkroom Cycles:10 Average:109.00 Median:95.50 stddev:19.36 (20.3%) stddev-sans-first:19.86 13:22:17 INFO - PROCESS | 2634 | Values: 95.0 95.0 96.0 109.0 131.0 96.0 97.0 127.0 148.0 96.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:93.00 stddev:3.03 (3.3%) stddev-sans-first:3.08 13:22:17 INFO - PROCESS | 2634 | Values: 90.0 93.0 96.0 98.0 94.0 89.0 90.0 92.0 93.0 89.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:57.00 stddev:0.97 (1.7%) stddev-sans-first:1.01 13:22:17 INFO - PROCESS | 2634 | Values: 57.0 56.0 55.0 57.0 57.0 55.0 56.0 58.0 57.0 57.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#9] json-stringify-tinderbox Cycles:10 Average:76.90 Median:76.50 stddev:8.24 (10.8%) stddev-sans-first:8.08 13:22:17 INFO - PROCESS | 2634 | Values: 68.0 70.0 79.0 72.0 82.0 76.0 77.0 76.0 97.0 72.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#10] stanford-crypto-aes Cycles:10 Average:87.90 Median:83.00 stddev:9.94 (12.0%) stddev-sans-first:10.49 13:22:17 INFO - PROCESS | 2634 | Values: 85.0 108.0 105.0 81.0 84.0 83.0 83.0 82.0 86.0 82.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:146.00 stddev:18.19 (12.5%) stddev-sans-first:19.20 13:22:17 INFO - PROCESS | 2634 | Values: 140.0 137.0 151.0 153.0 134.0 151.0 131.0 123.0 189.0 141.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.30 Median:177.00 stddev:27.07 (15.3%) stddev-sans-first:28.22 13:22:17 INFO - PROCESS | 2634 | Values: 163.0 182.0 148.0 161.0 179.0 223.0 226.0 175.0 154.0 162.0 13:22:17 INFO - PROCESS | 2634 | 13:22:17 INFO - PROCESS | 2634 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.50 stddev:2.72 (4.1%) stddev-sans-first:1.56 13:22:17 INFO - PROCESS | 2634 | Values: 59.0 67.0 65.0 65.0 68.0 65.0 68.0 64.0 66.0 68.0 13:22:17 INFO - PROCESS | 2634 | -------- Summary: end -------- 13:22:17 INFO - PROCESS | 2634 | 13:22:18 INFO - TEST-INFO | 2634: exit 0 13:22:18 INFO - TEST-OK | kraken | took 60106ms 13:22:18 INFO - SUITE-END | took 1173s 13:22:18 INFO - Completed test suite (00:19:34) 13:22:18 INFO - javascript benchmark 13:22:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7324.283538154339, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3396.660333966602, 3414.890160697774, 3416.624171341152, 3433.467812489065, 3436.8486557003403, 5867.4719275265215, 5928.081147422151, 5934.1692163097205, 5935.22842030536, 5942.970285148579, 5699.515541178995, 5876.588638795286, 5894.410558944114, 5935.109733539971, 5943.851403714909, 5255.500727430888, 5323.653962492425, 5389.83830485086, 5406.8918621627545, 5455.290812194409, 138.44745323676747, 5273.709945952971, 5338.946610533883, 5382.91925621116, 5407.215953686713, 5336.17289320156, 5345.999999999961, 5365.141577347606, 5374.086405311087, 5387.676739395649, 5384.273123128406, 5396.622236443451, 5406.375037994112, 5436.293281873332, 5513.751881165357, 5249.0, 5294.841154765363, 5335.439778823245, 5356.839294821123, 5412.134058550652, 5788.160716696056, 5892.558058145613, 5942.108683697436, 6033.42682445167, 6042.969785151046, 6168.136460895478, 6263.279722831841, 6306.621602703853, 6307.432331090224, 6339.302676705559, 6255.781047663356, 6286.465650419674, 6333.619982801047, 6341.556091073627, 6362.363763623647, 4990.775415106293, 6007.4893634041155, 6019.608725432833, 6033.245844269466, 6042.848928776816, 6252.812415627447, 6381.3937675920715, 6456.031595260749, 6485.4811615070685, 6537.509686773511, 6069.878602427927, 6197.0, 6296.874062518724, 6313.273973493016, 6324.1778568786685, 6270.184875966095, 6362.077498762654, 6366.236051673829, 6371.299157092716, 6371.39471750183, 6221.253449586078, 6256.436920677161, 6260.24877014752, 6267.1539342189135, 6322.968385158137, 6320.71556779946, 6322.652254126067, 6324.3991820776955, 6327.557071004985, 6353.237611486558, 5098.745062746848, 5133.4096578893905, 5146.4853514648985, 5161.922571161435, 5162.045021670928, 4451.3323001550025, 4490.348899409632, 4494.9325760113625, 4554.7039442436135, 4593.104344652827, 4940.456549779521, 5809.9419005809405, 6004.63972161663, 6010.158577799111, 6010.4891084258325, 6273.153124328249, 6274.623522588659, 6314.62112273265, 6319.6208227506495, 6332.778352757631, 6073.605215661057, 6078.848028799315, 6103.993220001014, 6110.725017374229, 6144.477719393813, 5497.752601132958, 5582.162675598693, 5621.100623900156, 5636.18275350072, 5638.126090455986, 6477.287498375175, 6523.086767852505, 6552.639604821685, 6611.07444957716, 6612.636305003271, 5845.386234445322, 6353.555251132377, 6361.332060133619, 6364.109024736448, 6392.073149393219, 6364.045393191059, 6443.420092191538, 6474.967625161844, 6554.672266386567, 6599.439047681001, 6272.655003974825, 6273.247210334789, 6332.398422149889, 6332.461740752087, 6366.554341196072, 6327.715252813542, 6341.048842673636, 6363.61818290904, 6365.0, 6366.045093236052, 6121.483458747687, 6189.226346706661, 6227.0, 6270.937290627217, 6299.055141728594, 6143.938560614337, 6223.253209614875, 6269.655168965751, 6286.402791734778, 6304.211973503312, 4947.653664243612, 5223.4776522347465, 5242.711650859239, 5423.3491980962535, 6092.360302168208, 6121.239585875057, 6141.486007784364, 6146.340488068107, 6187.628742275478, 6203.8138855834395, 6189.226346706661, 6198.2252218472695, 6203.534734894991, 6215.689215539114, 6218.9378106218355], "value": 5787.016527891376, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.78533767135934, 475.98377464114117, 488.5114885114885, 523.1577160771158, 523.6465385864541, 30243.243918902037, 30276.848615756946, 40864.591354086486, 41618.58381416185, 41656.79171604145, 41871.37192942101, 42538.14923701524, 42822.92942676427, 43061.138777224514, 43068.0, 9536.189423898977, 9713.125818676317, 9721.368111072794, 9739.610415583367, 9767.267454940873, 8275.172482751737, 9067.002629710727, 9645.08371704687, 9651.420914745102, 9671.661491847752, 9646.614135434575, 9678.806423871518, 9735.075167859042, 9741.756456088584, 9764.804703905953, 9505.239580833551, 9570.760730981747, 9686.370385924893, 9691.854622180674, 9695.951520242425, 9523.761905952337, 9549.713508594683, 9559.283053770994, 9634.75913102171, 9736.610535578568, 40069.59930400688, 40133.19733605311, 40517.594824051674, 40635.187296254204, 40843.0, 3336.666333366644, 3341.081202669285, 3408.386490431721, 3552.5381700379044, 3883.902902427462, 32477.51283730746, 33036.0, 33263.002109936744, 33454.498182527284, 33544.0, 3224.871005159791, 3269.869205231788, 3290.7038366546885, 3310.2220978070136, 3409.0, 440920.0, 444391.0, 446399.0, 447051.76474117744, 448604.0, 29199.41601167965, 34217.48673769896, 34994.9501514955, 61054.77890442255, 61558.69220653868, 32302.515462268086, 35113.0, 35445.468317975254, 35633.46549801755, 36172.63827361746, 14999.325030373659, 15080.698386032218, 15121.848781512044, 15138.470153544573, 15142.54572362831, 12747.936260318824, 12812.42344094518, 12826.294553799631, 12833.935830320788, 12878.613641590768, 7818.3354414875375, 7824.882626760603, 7829.177936316719, 7837.981062461843, 7921.683132674743, 3233.8383080845865, 3246.788958717676, 3258.25060236147, 3288.095773662262, 3308.93382132356, 929.772205809581, 937.5265490927175, 945.8675785390051, 978.8189185000798, 1153.429052618959, 28951.192110847584, 30868.228294292374, 31058.0, 31338.529922051188, 31726.36547269088, 1061.994690026545, 1131.7000994736402, 1171.9589814356457, 1193.797054500737, 1222.7554489102215, 15448.609625133791, 15984.440544580884, 15999.840001600069, 16592.83407165937, 16719.247633856507, 683270.0, 692344.0, 699497.0, 700855.0, 702035.0, 50876.745616271684, 55520.0, 60855.39144608497, 61509.69245153835, 61565.0, 1234.975300493985, 1334.873187047229, 1368.6509939965445, 1370.6847425092285, 1407.7536431124513, 27275.181744547695, 30502.69497305087, 30538.541921871634, 30675.539866901567, 31242.687573123978, 45612.85967850831, 47509.762451187526, 48684.269735954695, 49105.75447122742, 51985.48014519807, 505099.4745026251, 595688.0, 598330.0, 599476.0, 601192.0, 26772.59841102424, 27464.450710986068, 27639.447211055263, 27753.722462775113, 27939.62513186402, 40405.595944040186, 49093.0, 49196.0, 50022.49977500324, 50277.74861125671, 40598.59401405948, 40614.79692601518, 41061.38407923824, 41072.1785564293, 41115.355385784234, 40146.39780403355, 40201.0, 40651.59348406478, 41507.584924150375, 41698.74903752892, 39242.80378598089, 39376.40935386029, 40180.39729404003, 40363.3945490812, 41981.580184197766, 32756.34487310288, 35026.474602881484, 35613.287734245685, 35651.28697426089, 35894.461583076794, 23193.652095218247, 26332.21003369902, 26519.806608702267, 26674.12925466626, 26696.599551006362], "value": 18771.869358620806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.3499440983868, 372.5529364762284, 376.363944933063, 382.69766884161515, 395.89310886060764, 19505.219791208354, 20537.38387848365, 20681.379558613247, 21013.684794728055, 21346.786532134673, 20190.89904550479, 20271.59456810863, 20657.896710516427, 21064.89467552664, 21704.0, 5607.579431542651, 5963.135345374918, 6136.048912418582, 6177.938220617782, 6191.257049154108, 5997.940020599804, 6041.124037014631, 6102.542309326796, 6117.785877494289, 6119.26568811741, 5863.912041319383, 5923.703814809264, 5952.285725712921, 5974.372690867462, 5976.641401515923, 5888.5877988540815, 5996.940030599681, 6053.909191362133, 6054.33402325746, 6058.212432383806, 5197.324347834758, 5222.712750798704, 5226.843194704165, 5230.372355317349, 5232.790688372461, 25325.240242792745, 25865.0, 25944.221673349828, 26029.0, 26045.348866278306, 2252.5494901019697, 2487.614419764939, 2696.595510673395, 2790.0234917778816, 2830.5188118019987, 15448.382064717398, 16003.519894403187, 16084.517464475968, 16227.83772162275, 16343.42798002076, 1871.2421469304954, 1872.3166044393697, 1874.1097978460123, 1891.366392258595, 1933.2556965568217, 92449.0, 93115.0, 110048.0, 112958.87041129566, 115297.0, 10078.740157480315, 11189.328640281608, 11685.474153663106, 11830.526778928746, 11832.17174797773, 14500.492482763053, 14696.897732669879, 14747.262636868114, 14765.114093154445, 14772.48296309624, 7155.747744144754, 8602.612882420306, 8703.825923481621, 8742.213200811957, 8850.159234872677, 8675.436096653697, 8698.956505217433, 8760.386772925835, 8854.468731876108, 8893.333000025024, 4513.977430112828, 4555.293929440942, 4578.9542104579195, 4594.748573199176, 4625.514320996314, 1644.597073716947, 1933.3233368321257, 1968.153693911603, 1968.7498438491662, 1971.684530475117, 884.8893888263967, 932.7434955387323, 953.2897990996752, 970.8301047316692, 985.261054209343, 20280.79719202789, 21036.789632103788, 21383.35849924505, 21427.67858482124, 21583.892080539496, 791.705561407092, 872.5986046418592, 924.5885580916428, 954.71358592422, 977.6675930183629, 10972.725681858017, 11538.826917596243, 11555.595554155565, 11652.94173529127, 11680.88319116815, 639134.0, 643511.0, 646771.0, 647562.3653292067, 647732.7613361997, 95375.046249538, 124310.0, 134415.0, 143511.2824435892, 148742.0, 960.2462067277154, 969.1519920069939, 997.6258902911263, 999.5901680311038, 1004.4927311707687, 18569.16438760232, 19246.615067698287, 19316.613667726284, 19785.901070494554, 19859.205631774566, 56858.7157064212, 59933.101003485855, 59978.701171434244, 60869.69565152146, 61218.693906530185, 85893.28213435822, 86109.56945215484, 86223.0, 86304.70542941986, 88255.0, 6975.197852247056, 7508.324250817453, 7548.811279718051, 7852.214778522102, 8296.585170741559, 12153.69615759613, 13360.331983400985, 13512.121712089076, 13555.457781689016, 13670.93164534171, 11646.301221926711, 11782.234154779911, 11813.291202527877, 11839.881601183877, 11980.76038479243, 11104.833427498756, 11500.252483588874, 11563.190576659554, 11743.001844843284, 11852.881471185523, 11592.884071159518, 11633.6509904703, 11915.642530723746, 11966.820497692715, 12099.637010889688, 7644.426667999811, 7674.6930122794465, 7681.231876812274, 7705.653245603849, 7801.2198780121535, 11412.714682133013, 11607.245529040585, 11715.17993740464, 11812.0, 11926.045916326499], "value": 9876.406145854422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.872255858252, 1540.0759544273433, 1683.461292386436, 1724.6550689862022, 1725.8533024692902, 7999.800004999864, 8559.058503564604, 8573.271271941885, 9078.818423631523, 9103.726888193356, 8676.652933882637, 8719.694810681627, 8815.603297851596, 8836.602352894119, 8840.690575829847, 2347.3192774095533, 2363.326451961191, 2367.206985659806, 2370.419247284418, 2379.7977171940406, 2314.5602335556273, 2337.0301324950124, 2344.038944032947, 2351.2828587280874, 2351.8000969917575, 2356.1871154451774, 2367.8934447949796, 2377.7146742390937, 2383.261189031397, 2387.761223877607, 2348.4011577047913, 2366.9644955325684, 2372.0274687378264, 2374.7387787343378, 2376.5128148729555, 2355.9057637694473, 2365.680633114525, 2368.4552552912755, 2369.7037870266217, 2383.809295256375, 8868.600912958867, 8909.821803563957, 8993.820123597558, 9024.819503609891, 9036.096390360912, 5317.707526086064, 5467.6719396836315, 5476.2333273341765, 5477.178423236506, 5498.230247765316, 3471.9826400868087, 3482.181687303482, 3622.6196249393697, 3680.429533422324, 3686.686631636314, 1089.2701889733896, 1090.6782499162766, 1099.164634877491, 1099.3074363151243, 1114.3703807348822, 11537.365444900528, 11648.534058637644, 11744.530218791238, 11768.58809941648, 11795.29228246308, 3751.5873253942045, 4232.30167022444, 4282.614564689193, 4371.9944412785235, 4451.0, 7776.144624091458, 8040.316573091352, 9008.234300084436, 9206.17144457002, 9223.354365194373, 5277.287566178594, 5277.498637629419, 5283.0, 5285.814996475105, 5291.126964050965, 4462.732236065846, 4761.40482439695, 4923.75381230937, 4927.482614325444, 4951.96008838148, 3180.8866896586474, 3834.884953451401, 3860.1700634363747, 3873.6055020192707, 3936.075022369741, 1156.3235507228367, 1158.1198289300191, 1162.9008691836161, 1167.9941600291945, 1174.5008371442275, 900.2977677411629, 908.5956749246521, 923.2752289452748, 945.385499425379, 965.4255717847869, 5892.204552385459, 6025.307089684655, 6063.787767428119, 6101.603395779349, 6288.245410550763, 414.7138474452618, 425.52978958251305, 432.47022397562733, 433.9978300108479, 437.47502996404444, 4020.5175378954127, 4092.07928216149, 4093.201825643971, 4147.880072380441, 4156.958430415718, 9097.0, 10493.370397776158, 10997.505112269968, 11013.118950483942, 11030.0, 10759.78480430387, 10843.566257349617, 10899.455027248607, 10927.235093543535, 11022.118230541537, 6929.341712537301, 8239.670413183405, 8297.668093276323, 8353.457025293337, 8375.0, 6087.665178415053, 6132.78535251264, 6184.474319682878, 6252.468540174136, 6271.341509141657, 8836.646534138563, 10094.495275236355, 10280.280380373302, 10353.171746260432, 10366.844497332395, 8841.911580884109, 10098.091171794575, 10247.180225582084, 10378.584856605652, 10771.19216058783, 7073.858522829411, 7429.517081389692, 7582.090149182133, 7639.388848892187, 7681.231876812274, 7044.189918159477, 8539.060703322753, 8602.096779838026, 8613.82772344537, 8622.61198246068, 7504.0, 7672.232776722283, 7704.075510938499, 7720.227977202235, 7749.0, 7507.099148102263, 7544.4341674373545, 7584.393248539993, 7688.692452302069, 7726.652300646597, 7207.207207207098, 7248.891266630899, 7250.0, 7261.237570055068, 7273.309035641606, 4956.975215123901, 5091.287219789307, 5092.949070509248, 5163.767630456714, 5171.922421163761, 5175.275461435477, 5221.112410890234, 5226.477352264743, 5248.448912864094, 5337.0], "value": 4501.840301402248, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.77900795395493, 303.951367781155, 306.54018971542683, 306.6611394409179, 309.1637121586109, 4532.798808315791, 5416.050221920115, 5639.66162030278, 5675.631083979543, 5749.367569567345, 4561.977190114053, 5300.973495132529, 5660.745266463009, 5662.716864156786, 5668.412844403563, 3454.7236221102376, 3762.6425489578446, 4309.935350969738, 4312.757366169598, 4321.783910804463, 3099.5660607514965, 4277.25148099083, 4322.308430651096, 4332.328489084197, 4335.176316499871, 3889.6499315061637, 4175.624193822556, 4194.832206711743, 4216.9578304216875, 4222.387753775701, 3477.5479187705437, 3820.9808950955344, 3822.4648549203134, 3859.9228015439817, 4240.618344348993, 3649.2701459708164, 3654.83045425464, 3662.011256960606, 3664.4136938089778, 3676.0, 4625.121226966866, 4817.325574419584, 5114.105031619451, 5140.357455318085, 5546.91679624806, 3950.4074388841905, 4716.622670186377, 4793.952060479421, 4803.615710743132, 4828.5412885775795, 5733.283339582552, 5890.558208134365, 5892.440218179266, 5930.021546444831, 5943.64338139713, 3550.467429885538, 3702.2780557791243, 3759.3233218020746, 3976.741511801724, 3979.6617287530594, 5407.783688652449, 6211.658358790265, 6232.657203853786, 6283.05754136874, 6321.431071203614, 4013.4180543821567, 4025.054112283611, 4032.0121570215483, 4033.3748269018347, 4043.433919251307, 3867.5165604299464, 4071.97964010184, 4080.4083407905687, 4083.285425050664, 4098.569650186688, 4377.0, 4723.7401942893475, 4741.5021422750115, 4778.665493415428, 4805.303231031481, 5680.573956953245, 5898.8820223595285, 5912.575843903979, 5960.37416071315, 6014.3761184479945, 1350.4463170100212, 1385.0235583913318, 1385.6051025457696, 1387.2797730813718, 1387.4380875745137, 752.6527515746861, 820.6389188757047, 821.6894053983887, 848.0544193224633, 854.1629203380597, 4298.5384969110655, 4480.857381367796, 4486.3494793254795, 4656.837010704677, 4692.554207350297, 4195.937060944088, 4563.338315944236, 4750.501197374226, 4825.710457372569, 5177.689338639693, 3976.840926362971, 4301.11827075455, 4384.649228061748, 4613.3324007414185, 4666.510016448224, 2285.7656865292556, 2722.992492777685, 2726.8091233613854, 2728.2770065932546, 2745.7391547802927, 4366.890827729332, 5350.571954243651, 5351.411344752152, 5372.006178856924, 5377.902617978992, 4678.228092364721, 4959.032988567267, 5169.836786723033, 5257.579393648499, 5268.762905669254, 5113.346854362587, 5331.640431689972, 5332.120200166929, 5343.62594618373, 5373.167159090347, 4608.930866036945, 4616.960159860122, 4987.476314986874, 5086.745662716923, 5105.285260063668, 4175.081482073939, 4713.3401323814005, 4750.501197374226, 5030.647854650139, 5068.239764035424, 4540.796688877384, 4551.175753701087, 5013.896942672606, 5015.724135172601, 5237.0, 3217.324361883937, 3527.876524321636, 3530.3998320286128, 3530.7579686899517, 3535.5934067582557, 4133.731307465006, 4206.621404073648, 5047.61190672568, 5104.213525266276, 5528.77530733453, 5399.70301633414, 5893.202573215211, 5909.852253693692, 5931.792387266598, 6000.669963152069, 5895.4399332063385, 5905.379935106924, 5915.2310199675485, 5938.96068188074, 5976.223090998143, 4894.751838281216, 5031.572316353151, 5444.339476459718, 5489.917651235314, 5696.060150075191, 5635.9436405635415, 5832.24180856486, 5888.4700376966275, 5920.37836027211, 5949.3753155918, 4657.69724967876, 4929.605631549539, 5317.813876514303, 5637.406792875159, 5802.361740208489], "value": 4005.074006010492, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.7751730687525, 698.6262349642941, 727.3744579661491, 728.5919884864476, 745.817274767682, 15165.772513412294, 15298.464553740621, 15386.769198462032, 15646.608834779136, 15689.52931412058, 14207.934404919646, 14212.71574568508, 14310.642233944156, 14318.64203394913, 14331.570052898403, 679.7450955891541, 816.6692489541745, 838.4591938199858, 841.8105926166625, 842.2419822160043, 841.1798496465958, 871.4509858788954, 872.380609767063, 872.415481627308, 872.8647059705755, 817.5544328341039, 854.444611002847, 903.0472851142042, 913.684778751333, 914.9359544831865, 793.5042444991204, 818.9181081891822, 876.4084243135858, 890.9109089091104, 906.60109551797, 651.4072194303161, 663.2207156591035, 665.3712241931377, 674.8886433738427, 677.2820809941428, 15325.23373831304, 15461.304241309055, 15482.071075735492, 15485.303161357766, 15492.147931863743, 11956.641300760992, 14904.925475372662, 14936.70126597462, 15041.548753537412, 15049.398024079024, 10553.47232638365, 11917.940410297893, 11923.284602923852, 12216.694582635417, 12461.875381246162, 3894.5131858517684, 3938.822752976123, 4021.718479706422, 4060.4315395844606, 4067.5118985721606, 111329.0, 112294.43852780765, 116700.83299166984, 117607.0, 119753.99999999913, 11439.0, 11538.289708167193, 11658.009069229041, 11728.413579321, 11793.882061179278, 22547.774522254895, 23068.884655576614, 23989.640155397683, 24054.0, 24187.395315117265, 7856.292933636, 7909.288164065147, 8219.630116644765, 8250.174982501701, 8481.982162140459, 4664.113818374498, 4670.229412147026, 4709.222978208626, 4763.0, 4842.249451335048, 3602.873899413508, 3633.3459977204357, 3638.235970446236, 3710.8330125144435, 3729.4405839123806, 659.3208994735335, 676.2594958520413, 676.9763058292937, 680.877442060424, 692.3457332820436, 570.0508653092637, 624.3506752976854, 662.2450406536552, 673.4309508465338, 685.951844794738, 9312.534373281309, 9509.610988530429, 9515.0, 9653.758656033655, 9698.903010969942, 560.9242752228479, 645.0099097884818, 662.9767958121442, 673.6328700858044, 675.3685304240453, 4442.711223770445, 4649.349091127245, 4706.0, 5144.202648589475, 5207.3490813648295, 139719.30140349234, 164549.0, 167520.0, 169278.0, 174073.0, 101870.0, 102508.48745756224, 118191.0, 132553.0, 133398.33300833433, 116649.0, 116806.0, 118933.40533297451, 119143.48993355573, 120488.39755801165, 9390.530473476436, 9906.851397228904, 9922.702318930444, 9931.255155863195, 10203.591856325664, 56430.7178464105, 56757.14864276956, 61408.0, 61537.69231153816, 63185.052224217594, 82226.17773822186, 84656.57671711603, 89424.5528772378, 98473.50763246138, 98926.51610225708, 13405.0, 13409.463621455423, 13482.123661961941, 13484.234762934571, 13591.79612305836, 15279.0, 15317.693646127238, 15414.075155490706, 15848.366065357257, 16036.518904432885, 14195.219262940638, 14313.856861431252, 14357.066790658992, 14410.927945360207, 14769.852301477278, 14125.576232713034, 14177.787333189804, 14210.0, 14239.715205696035, 14721.484748033767, 12440.75118497643, 12613.621591352274, 12639.115261931944, 13507.122037067558, 14123.072776549194, 10314.381137131797, 11150.498227579941, 11366.886331136582, 11618.186726929034, 11889.108316876096, 10340.896591033994, 11080.156329921674, 11290.717732056764, 11793.41032948332, 11797.52809887595], "value": 7979.641318144681, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 105.0, 115.0, 117.0, 118.0, 112.0, 114.0, 116.0, 114.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 130.0, 154.0, 107.0, 131.0, 130.0, 114.0, 155.0, 138.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 200.0, 196.0, 212.0, 228.0, 205.0, 196.0, 201.0, 202.0, 201.0], "value": 204.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 85.0, 99.0, 134.0, 58.0, 69.0, 57.0, 62.0, 130.0, 59.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 75.0, 122.0, 83.0, 105.0, 115.0, 114.0, 73.0, 71.0, 118.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 85.0, 135.0, 132.0, 90.0, 87.0, 93.0, 88.0, 90.0, 89.0], "value": 99.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 109.0, 131.0, 96.0, 97.0, 127.0, 148.0, 96.0], "value": 109.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 96.0, 98.0, 94.0, 89.0, 90.0, 92.0, 93.0, 89.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 57.0, 57.0, 55.0, 56.0, 58.0, 57.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 79.0, 72.0, 82.0, 76.0, 77.0, 76.0, 97.0, 72.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 108.0, 105.0, 81.0, 84.0, 83.0, 83.0, 82.0, 86.0, 82.0], "value": 87.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 137.0, 151.0, 153.0, 134.0, 151.0, 131.0, 123.0, 189.0, 141.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 182.0, 148.0, 161.0, 179.0, 223.0, 226.0, 175.0, 154.0, 162.0], "value": 177.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 65.0, 65.0, 68.0, 65.0, 68.0, 64.0, 66.0, 68.0], "value": 65.5, "unit": "score"}]}]} 13:22:18 INFO - Return code: 0 13:22:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:22:18 ERROR - # TBPL SUCCESS # 13:22:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:22:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:22:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:22:18 INFO - 2016-06-30 13:22:18.931 screenresolution[2639:82864] starting screenresolution argv=screenresolution get 13:22:18 INFO - 2016-06-30 13:22:18.934 screenresolution[2639:82864] Display 0: 1600x1200x32@60 13:22:18 INFO - 2016-06-30 13:22:18.940 screenresolution[2640:82867] starting screenresolution argv=screenresolution list 13:22:18 INFO - Available Modes on Display 0 13:22:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:22:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:22:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:22:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:22:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:22:19 INFO - Intel Iris: 13:22:19 INFO - Chipset Model: Intel Iris 13:22:19 INFO - Type: GPU 13:22:19 INFO - Bus: Built-In 13:22:19 INFO - VRAM (Dynamic, Max): 1536 MB 13:22:19 INFO - Vendor: Intel (0x8086) 13:22:19 INFO - Device ID: 0x0a2e 13:22:19 INFO - Revision ID: 0x0009 13:22:19 INFO - Displays: 13:22:19 INFO - Display: 13:22:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:22:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:22:19 INFO - Display Serial Number: 1600x1200 60 13:22:19 INFO - Main Display: Yes 13:22:19 INFO - Mirror: Off 13:22:19 INFO - Online: Yes 13:22:19 INFO - Rotation: Supported 13:22:19 INFO - Return code: 0 13:22:19 INFO - Running post-action listener: _resource_record_post_action 13:22:19 INFO - ##### 13:22:19 INFO - ##### Finished run-tests step (success) 13:22:19 INFO - ##### 13:22:19 INFO - Running post-run listener: _resource_record_post_run 13:22:19 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 86016; Write bytes: 709025280; Read time: 2; Write time: 1950 13:22:19 INFO - TinderboxPrint: CPU usage
54.3% 13:22:19 INFO - TinderboxPrint: I/O read bytes / time
86,016 / 2 13:22:19 INFO - TinderboxPrint: I/O write bytes / time
709,025,280 / 1,950 13:22:19 INFO - TinderboxPrint: CPU idle
2,212.1 (45.7%) 13:22:19 INFO - TinderboxPrint: CPU system
975.0 (20.2%) 13:22:19 INFO - TinderboxPrint: CPU user
1,650.6 (34.1%) 13:22:19 INFO - TinderboxPrint: Swap in / out
406,138,880 / 0 13:22:19 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 393970176; Write bytes: 389666304; Read time: 29269; Write time: 783 13:22:19 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 86016; Write bytes: 298252288; Read time: 2; Write time: 1113 13:22:19 INFO - Running post-run listener: _upload_blobber_files 13:22:19 INFO - Blob upload gear active. 13:22:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:22:19 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 13:22:19 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'] 13:22:19 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 13:22:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:22:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:22:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:22:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:20 INFO - (blobuploader) - INFO - Done attempting. 13:22:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:22:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:22:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:21 INFO - (blobuploader) - INFO - Done attempting. 13:22:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:22:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:22:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:22:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:22:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:22:24 INFO - (blobuploader) - INFO - Done attempting. 13:22:24 INFO - (blobuploader) - INFO - Iteration through files over. 13:22:24 INFO - Return code: 0 13:22:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:22:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:22:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98f24490f1f043a91e8410235d84375c531d6643dbf7e1995749a06fe9db9e331b5acd1cf033445f75958c2b045c95f9102ce24ab23ab9e940296f3558ccd04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8409ce7b2739feb8511924361c9ada735ba58f899751e49b2159ff8bc57bbe7325865744c14eef8b4ede351dddb0cd3666053a881d1387e6f856ae501f9f53b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38458a3671cb9557f73018f09efdf86327ea7139c2014d3dce198d67929d1b092dfb2c94c86a261ebaef71952a3b83d1d980b2f29536dd5e1e197492be3705f3"} 13:22:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:22:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:22:24 INFO - Contents: 13:22:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98f24490f1f043a91e8410235d84375c531d6643dbf7e1995749a06fe9db9e331b5acd1cf033445f75958c2b045c95f9102ce24ab23ab9e940296f3558ccd04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8409ce7b2739feb8511924361c9ada735ba58f899751e49b2159ff8bc57bbe7325865744c14eef8b4ede351dddb0cd3666053a881d1387e6f856ae501f9f53b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38458a3671cb9557f73018f09efdf86327ea7139c2014d3dce198d67929d1b092dfb2c94c86a261ebaef71952a3b83d1d980b2f29536dd5e1e197492be3705f3"} 13:22:24 INFO - Running post-run listener: copy_logs_to_upload_dir 13:22:24 INFO - Copying logs to upload dir... 13:22:24 INFO - mkdir: /builds/slave/test/build/upload/logs 13:22:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.896017 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2016-06-30 13:22:24.678739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 13:22:24.689080) ========= 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.iVq53PldDx/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.rUfllImX16/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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/98f24490f1f043a91e8410235d84375c531d6643dbf7e1995749a06fe9db9e331b5acd1cf033445f75958c2b045c95f9102ce24ab23ab9e940296f3558ccd04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8409ce7b2739feb8511924361c9ada735ba58f899751e49b2159ff8bc57bbe7325865744c14eef8b4ede351dddb0cd3666053a881d1387e6f856ae501f9f53b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38458a3671cb9557f73018f09efdf86327ea7139c2014d3dce198d67929d1b092dfb2c94c86a261ebaef71952a3b83d1d980b2f29536dd5e1e197492be3705f3"} build_url:https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011440 build_url: 'https://queue.taskcluster.net/v1/task/E_dDd7HBQXm0syBEf4Dg5w/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/98f24490f1f043a91e8410235d84375c531d6643dbf7e1995749a06fe9db9e331b5acd1cf033445f75958c2b045c95f9102ce24ab23ab9e940296f3558ccd04b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8409ce7b2739feb8511924361c9ada735ba58f899751e49b2159ff8bc57bbe7325865744c14eef8b4ede351dddb0cd3666053a881d1387e6f856ae501f9f53b8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/38458a3671cb9557f73018f09efdf86327ea7139c2014d3dce198d67929d1b092dfb2c94c86a261ebaef71952a3b83d1d980b2f29536dd5e1e197492be3705f3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 13:22:24.729530) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 13:22:24.732868) ========= 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.iVq53PldDx/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.rUfllImX16/Listeners TMPDIR=/var/folders/3m/qxqc0m_j4y9b2z26qf6v21y000000w/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.005256 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 13:22:24.781491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 13:22:24.784838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 13:22:24.785136) ========= ========= Total master_lag: 0.48 =========