builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0170 starttime: 1468491155.0 results: success (0) buildid: 20160714020544 builduid: 200501155004462089108747c9c6ff97 revision: cb1812acfcd1ed05706e0bd9405668d11516cfd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.004237) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.004625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.004898) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.027596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.027856) ========= 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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-14 03:12:35-- 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% 7.94M=0.001s 2016-07-14 03:12:35 (7.94 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.147530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.148156) ========= 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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.021146 ========= master_lag: 0.47 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:35.637712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-14 03:12:35.638065) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cb1812acfcd1ed05706e0bd9405668d11516cfd4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev cb1812acfcd1ed05706e0bd9405668d11516cfd4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ib6hBEOxv3/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.dtGkqquW8c/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-14 03:12:35,712 truncating revision to first 12 chars 2016-07-14 03:12:35,712 Setting DEBUG logging. 2016-07-14 03:12:35,712 attempt 1/10 2016-07-14 03:12:35,712 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cb1812acfcd1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 03:12:37,251 unpacking tar archive at: autoland-cb1812acfcd1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.040436 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-14 03:12:37.709605) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:37.709956) ========= script_repo_revision: cb1812acfcd1ed05706e0bd9405668d11516cfd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:37.710414) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:37.710722) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:12:37.728467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-07-14 03:12:37.728798) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ib6hBEOxv3/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.dtGkqquW8c/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:12:37 INFO - MultiFileLogger online at 20160714 03:12:37 in /builds/slave/test 03:12:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 03:12:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:12:37 INFO - {'append_to_log': False, 03:12:37 INFO - 'base_work_dir': '/builds/slave/test', 03:12:37 INFO - 'blob_upload_branch': 'Autoland', 03:12:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:12:37 INFO - 'branch': 'Autoland', 03:12:37 INFO - 'buildbot_json_path': 'buildprops.json', 03:12:37 INFO - 'config_files': ('talos/mac_config.py',), 03:12:37 INFO - 'default_actions': ('clobber', 03:12:37 INFO - 'read-buildbot-config', 03:12:37 INFO - 'download-and-extract', 03:12:37 INFO - 'populate-webroot', 03:12:37 INFO - 'create-virtualenv', 03:12:37 INFO - 'install', 03:12:37 INFO - 'run-tests'), 03:12:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:12:37 INFO - 'download_minidump_stackwalk': True, 03:12:37 INFO - 'download_symbols': 'ondemand', 03:12:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:12:37 INFO - 'tooltool.py': '/tools/tooltool.py', 03:12:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:12:37 INFO - '/tools/misc-python/virtualenv.py')}, 03:12:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:12:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:12:37 INFO - 'installer_path': 'installer.exe', 03:12:37 INFO - 'log_level': 'info', 03:12:37 INFO - 'log_name': 'talos', 03:12:37 INFO - 'log_to_console': True, 03:12:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:12:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:12:37 INFO - 'opt_config_files': (), 03:12:37 INFO - 'pip_index': False, 03:12:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:12:37 INFO - 'cmd': ('bash', 03:12:37 INFO - '-c', 03:12:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:12:37 INFO - 'enabled': True, 03:12:37 INFO - 'halt_on_failure': False, 03:12:37 INFO - 'name': 'check_screen_resolution'},), 03:12:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:12:37 INFO - 'cmd': ('bash', 03:12:37 INFO - '-c', 03:12:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:12:37 INFO - 'enabled': True, 03:12:37 INFO - 'halt_on_failure': False, 03:12:37 INFO - 'name': 'check_screen_resolution'},), 03:12:37 INFO - 'run_cmd_checks_enabled': True, 03:12:37 INFO - 'sps_profile': False, 03:12:37 INFO - 'sps_profile_interval': 0, 03:12:37 INFO - 'suite': 'dromaeojs-e10s', 03:12:37 INFO - 'system_bits': '32', 03:12:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:12:37 INFO - 'title': 't-yosemite-r7-0170', 03:12:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:12:37 INFO - 'use_talos_json': True, 03:12:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:12:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:12:37 INFO - 'work_dir': 'build'} 03:12:37 INFO - ##### 03:12:37 INFO - ##### Running clobber step. 03:12:37 INFO - ##### 03:12:37 INFO - Running pre-action listener: _resource_record_pre_action 03:12:37 INFO - Running main action method: clobber 03:12:37 INFO - rmtree: /builds/slave/test/build 03:12:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:12:38 INFO - Running post-action listener: _resource_record_post_action 03:12:38 INFO - ##### 03:12:38 INFO - ##### Finished clobber step (success) 03:12:38 INFO - ##### 03:12:38 INFO - ##### 03:12:38 INFO - ##### Running read-buildbot-config step. 03:12:38 INFO - ##### 03:12:38 INFO - Running pre-action listener: _resource_record_pre_action 03:12:38 INFO - Running main action method: read_buildbot_config 03:12:38 INFO - Using buildbot properties: 03:12:38 INFO - { 03:12:38 INFO - "project": "", 03:12:38 INFO - "product": "firefox", 03:12:38 INFO - "script_repo_revision": "production", 03:12:38 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 03:12:38 INFO - "repository": "", 03:12:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 03:12:38 INFO - "buildid": "20160714020544", 03:12:38 INFO - "pgo_build": "False", 03:12:38 INFO - "basedir": "/builds/slave/test", 03:12:38 INFO - "buildnumber": 12, 03:12:38 INFO - "slavename": "t-yosemite-r7-0170", 03:12:38 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:12:38 INFO - "platform": "yosemite_r7", 03:12:38 INFO - "scheduler": "tests-autoland-macosx64-talos", 03:12:38 INFO - "branch": "autoland", 03:12:38 INFO - "repo_path": "integration/autoland", 03:12:38 INFO - "revision": "cb1812acfcd1ed05706e0bd9405668d11516cfd4", 03:12:38 INFO - "stage_platform": "macosx64", 03:12:38 INFO - "builduid": "200501155004462089108747c9c6ff97", 03:12:38 INFO - "slavebuilddir": "test" 03:12:38 INFO - } 03:12:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 03:12:38 INFO - Running post-action listener: _resource_record_post_action 03:12:38 INFO - ##### 03:12:38 INFO - ##### Finished read-buildbot-config step (success) 03:12:38 INFO - ##### 03:12:38 INFO - ##### 03:12:38 INFO - ##### Running download-and-extract step. 03:12:38 INFO - ##### 03:12:38 INFO - Running pre-action listener: _resource_record_pre_action 03:12:38 INFO - Running main action method: download_and_extract 03:12:38 INFO - mkdir: /builds/slave/test/build/tests 03:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:38 INFO - https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:12:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:12:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 03:12:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:12:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:12:39 INFO - Downloaded 1199 bytes. 03:12:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 03:12:39 INFO - Using the following test package requirements: 03:12:39 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:12:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 03:12:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 03:12:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'jsshell-mac.zip'], 03:12:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 03:12:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 03:12:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 03:12:39 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 03:12:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 03:12:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 03:12:39 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 03:12:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:39 INFO - https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:12:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:12:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:12:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:12:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:12:40 INFO - Downloaded 18827623 bytes. 03:12:40 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'] 03:12:40 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 03:12:44 INFO - Return code: 0 03:12:44 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 03:12: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')]} 03:12:44 INFO - https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:12:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:12:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:12:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:12:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:12:44 WARNING - URL Error: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 03:12:44 INFO - Running command: ['nslookup', u'queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com'] 03:12:44 INFO - Copy/paste: nslookup queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com 03:12:44 INFO - Server: 10.26.75.40 03:12:44 INFO - Address: 10.26.75.40#53 03:12:44 INFO - queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com canonical name = proxxy1.srv.releng.scl3.mozilla.com. 03:12:44 INFO - Name: proxxy1.srv.releng.scl3.mozilla.com 03:12:44 INFO - Address: 10.26.48.46 03:12:44 INFO - Return code: 0 03:12:44 INFO - retry: attempt #1 caught exception: 03:12:44 INFO - retry: Failed, sleeping 30 seconds before retrying 03:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 #2 03:13:15 INFO - Downloaded 18827623 bytes. 03:13:15 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'] 03:13:15 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 03:13:18 INFO - Return code: 0 03:13:18 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')]} 03:13:18 INFO - https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:13:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:13:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 03:13:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:13:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:13:20 INFO - Downloaded 14403317 bytes. 03:13:20 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'] 03:13:20 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 03:13:20 INFO - Return code: 0 03:13:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:20 INFO - https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:13:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:13:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:13:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 03:13:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I0QHab27RJyxOdVABR3DKw/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 03:13:23 INFO - Downloaded 112787098 bytes. 03:13:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:13:23 INFO - mkdir: /builds/slave/test/properties 03:13:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:13:23 INFO - Writing to file /builds/slave/test/properties/build_url 03:13:23 INFO - Contents: 03:13:23 INFO - build_url:https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 03:13:24 INFO - Running post-action listener: _resource_record_post_action 03:13:24 INFO - Running post-action listener: set_extra_try_arguments 03:13:24 INFO - ##### 03:13:24 INFO - ##### Finished download-and-extract step (success) 03:13:24 INFO - ##### 03:13:24 INFO - ##### 03:13:24 INFO - ##### Running populate-webroot step. 03:13:24 INFO - ##### 03:13:24 INFO - Running pre-action listener: _resource_record_pre_action 03:13:24 INFO - Running main action method: populate_webroot 03:13:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:13:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:13:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:13:24 INFO - '--tppagecycles', 03:13:24 INFO - '7'], 03:13:24 INFO - 'tests': ['tsvgm']}}, 03:13:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:13:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:13:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:13:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:13:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:13:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['damp', 'tps']}, 03:13:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'tests': ['damp', 'tps']}, 03:13:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['dromaeo_dom']}, 03:13:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:13:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['basic_compositor_video']}, 03:13:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:13:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['a11yr', 03:13:24 INFO - 'ts_paint', 03:13:24 INFO - 'tpaint', 03:13:24 INFO - 'sessionrestore', 03:13:24 INFO - 'sessionrestore_no_auto_restore', 03:13:24 INFO - 'tabpaint']}, 03:13:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:13:24 INFO - 'ts_paint', 03:13:24 INFO - 'tpaint', 03:13:24 INFO - 'sessionrestore', 03:13:24 INFO - 'sessionrestore_no_auto_restore', 03:13:24 INFO - 'tabpaint']}, 03:13:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:13:24 INFO - 'ts_paint', 03:13:24 INFO - 'tpaint', 03:13:24 INFO - 'sessionrestore', 03:13:24 INFO - 'sessionrestore_no_auto_restore', 03:13:24 INFO - 'tabpaint']}, 03:13:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:13:24 INFO - 'ts_paint', 03:13:24 INFO - 'tpaint', 03:13:24 INFO - 'sessionrestore', 03:13:24 INFO - 'sessionrestore_no_auto_restore', 03:13:24 INFO - 'tabpaint']}, 03:13:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['a11yr', 03:13:24 INFO - 'ts_paint', 03:13:24 INFO - 'tpaint', 03:13:24 INFO - 'sessionrestore', 03:13:24 INFO - 'sessionrestore_no_auto_restore', 03:13:24 INFO - 'tabpaint']}, 03:13:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['a11yr', 03:13:24 INFO - 'ts_paint', 03:13:24 INFO - 'tpaint', 03:13:24 INFO - 'sessionrestore', 03:13:24 INFO - 'sessionrestore_no_auto_restore', 03:13:24 INFO - 'tabpaint']}, 03:13:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['tsvgx', 03:13:24 INFO - 'tsvgr_opacity', 03:13:24 INFO - 'tart', 03:13:24 INFO - 'tscrollx', 03:13:24 INFO - 'cart']}, 03:13:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:13:24 INFO - 'tsvgr_opacity', 03:13:24 INFO - 'tart', 03:13:24 INFO - 'tscrollx', 03:13:24 INFO - 'cart']}, 03:13:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'talos_options': ['--disable-e10s'], 03:13:24 INFO - 'tests': ['tp5o']}, 03:13:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'tests': ['tp5o']}, 03:13:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'talos_options': ['--disable-e10s', 03:13:24 INFO - '--xperf_path', 03:13:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:24 INFO - 'tests': ['tp5n']}, 03:13:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:13:24 INFO - 'talos_options': ['--xperf_path', 03:13:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:13:24 INFO - 'tests': ['tp5n']}}, 03:13:24 INFO - 'talos.zip': {'path': '', 03:13:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:13:24 INFO - Running post-action listener: _resource_record_post_action 03:13:24 INFO - ##### 03:13:24 INFO - ##### Finished populate-webroot step (success) 03:13:24 INFO - ##### 03:13:24 INFO - ##### 03:13:24 INFO - ##### Running create-virtualenv step. 03:13:24 INFO - ##### 03:13:24 INFO - Running pre-action listener: _resource_record_pre_action 03:13:24 INFO - Running main action method: create_virtualenv 03:13:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:13:24 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 03:13:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:13:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:13:24 INFO - Using real prefix '/tools/python27' 03:13:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:13:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:13:27 INFO - Installing pip.................done. 03:13:27 INFO - Return code: 0 03:13:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:27 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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:27 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 03:13:27 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 03:13:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:27 INFO - 'HOME': '/Users/cltbld', 03:13:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:27 INFO - 'LOGNAME': 'cltbld', 03:13:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:27 INFO - 'MOZ_NO_REMOTE': '1', 03:13:27 INFO - 'NO_EM_RESTART': '1', 03:13:27 INFO - 'PAGER': '/bin/cat', 03:13:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:27 INFO - 'PWD': '/builds/slave/test', 03:13:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:27 INFO - 'SHELL': '/bin/bash', 03:13:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:27 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:27 INFO - 'USER': 'cltbld', 03:13:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:27 INFO - 'XPC_FLAGS': '0x0', 03:13:27 INFO - 'XPC_SERVICE_NAME': '0', 03:13:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:28 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 03:13:28 INFO - Cleaning up... 03:13:28 INFO - Return code: 0 03:13:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:13:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:13:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:28 INFO - 'HOME': '/Users/cltbld', 03:13:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:28 INFO - 'LOGNAME': 'cltbld', 03:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:28 INFO - 'MOZ_NO_REMOTE': '1', 03:13:28 INFO - 'NO_EM_RESTART': '1', 03:13:28 INFO - 'PAGER': '/bin/cat', 03:13:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:28 INFO - 'PWD': '/builds/slave/test', 03:13:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:28 INFO - 'SHELL': '/bin/bash', 03:13:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:28 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:28 INFO - 'USER': 'cltbld', 03:13:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:28 INFO - 'XPC_FLAGS': '0x0', 03:13:28 INFO - 'XPC_SERVICE_NAME': '0', 03:13:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:28 INFO - Downloading/unpacking psutil>=3.1.1 03:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:31 INFO - Installing collected packages: psutil 03:13:31 INFO - Running setup.py install for psutil 03:13:31 INFO - building 'psutil._psutil_osx' extension 03:13:31 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 03:13:31 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 03:13:31 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 03:13:31 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 03:13:31 INFO - building 'psutil._psutil_posix' extension 03:13:31 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 03:13:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:13:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:13:31 INFO - ^ 03:13:31 INFO - 1 warning generated. 03:13:31 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 03:13:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:13:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:13:32 INFO - Successfully installed psutil 03:13:32 INFO - Cleaning up... 03:13:32 INFO - Return code: 0 03:13:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:32 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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:32 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 03:13:32 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 03:13:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:32 INFO - 'HOME': '/Users/cltbld', 03:13:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:32 INFO - 'LOGNAME': 'cltbld', 03:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:32 INFO - 'MOZ_NO_REMOTE': '1', 03:13:32 INFO - 'NO_EM_RESTART': '1', 03:13:32 INFO - 'PAGER': '/bin/cat', 03:13:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:32 INFO - 'PWD': '/builds/slave/test', 03:13:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:32 INFO - 'SHELL': '/bin/bash', 03:13:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:32 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:32 INFO - 'USER': 'cltbld', 03:13:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:32 INFO - 'XPC_FLAGS': '0x0', 03:13:32 INFO - 'XPC_SERVICE_NAME': '0', 03:13:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:13:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:13:35 INFO - Installing collected packages: mozsystemmonitor 03:13:35 INFO - Running setup.py install for mozsystemmonitor 03:13:35 INFO - Successfully installed mozsystemmonitor 03:13:35 INFO - Cleaning up... 03:13:35 INFO - Return code: 0 03:13:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:13:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:35 INFO - 'HOME': '/Users/cltbld', 03:13:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:35 INFO - 'LOGNAME': 'cltbld', 03:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:35 INFO - 'MOZ_NO_REMOTE': '1', 03:13:35 INFO - 'NO_EM_RESTART': '1', 03:13:35 INFO - 'PAGER': '/bin/cat', 03:13:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:35 INFO - 'PWD': '/builds/slave/test', 03:13:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:35 INFO - 'SHELL': '/bin/bash', 03:13:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:35 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:35 INFO - 'USER': 'cltbld', 03:13:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:35 INFO - 'XPC_FLAGS': '0x0', 03:13:35 INFO - 'XPC_SERVICE_NAME': '0', 03:13:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:13:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:38 INFO - Downloading functools32-3.2.3-2.tar.gz 03:13:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:13:38 INFO - warning: no files found matching '*.txt' 03:13:38 INFO - no previously-included directories found matching 'build' 03:13:38 INFO - no previously-included directories found matching 'dist' 03:13:38 INFO - no previously-included directories found matching '.git*' 03:13:38 INFO - Installing collected packages: jsonschema, functools32 03:13:38 INFO - Running setup.py install for functools32 03:13:38 INFO - warning: no files found matching '*.txt' 03:13:38 INFO - no previously-included directories found matching 'build' 03:13:38 INFO - no previously-included directories found matching 'dist' 03:13:38 INFO - no previously-included directories found matching '.git*' 03:13:38 INFO - Successfully installed jsonschema functools32 03:13:38 INFO - Cleaning up... 03:13:39 INFO - Return code: 0 03:13:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:39 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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:39 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 03:13:39 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 03:13:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:39 INFO - 'HOME': '/Users/cltbld', 03:13:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:39 INFO - 'LOGNAME': 'cltbld', 03:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:39 INFO - 'MOZ_NO_REMOTE': '1', 03:13:39 INFO - 'NO_EM_RESTART': '1', 03:13:39 INFO - 'PAGER': '/bin/cat', 03:13:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:39 INFO - 'PWD': '/builds/slave/test', 03:13:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:39 INFO - 'SHELL': '/bin/bash', 03:13:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:39 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:39 INFO - 'USER': 'cltbld', 03:13:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:39 INFO - 'XPC_FLAGS': '0x0', 03:13:39 INFO - 'XPC_SERVICE_NAME': '0', 03:13:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:13:39 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 03:13:39 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 03:13:39 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 03:13:39 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 03:13:39 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 03:13:39 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 03:13:42 INFO - Downloading blobuploader-1.2.4.tar.gz 03:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:13:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:13:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:13:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:13:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:13:43 INFO - Downloading docopt-0.6.1.tar.gz 03:13:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:13:43 INFO - Installing collected packages: blobuploader, requests, docopt 03:13:43 INFO - Running setup.py install for blobuploader 03:13:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:13:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:13:43 INFO - Running setup.py install for requests 03:13:44 INFO - Running setup.py install for docopt 03:13:44 INFO - Successfully installed blobuploader requests docopt 03:13:44 INFO - Cleaning up... 03:13:44 INFO - Return code: 0 03:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:44 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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:44 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 03:13:44 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 03:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:44 INFO - 'HOME': '/Users/cltbld', 03:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:44 INFO - 'LOGNAME': 'cltbld', 03:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:44 INFO - 'MOZ_NO_REMOTE': '1', 03:13:44 INFO - 'NO_EM_RESTART': '1', 03:13:44 INFO - 'PAGER': '/bin/cat', 03:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:44 INFO - 'PWD': '/builds/slave/test', 03:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:44 INFO - 'SHELL': '/bin/bash', 03:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:44 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:44 INFO - 'USER': 'cltbld', 03:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:44 INFO - 'XPC_FLAGS': '0x0', 03:13:44 INFO - 'XPC_SERVICE_NAME': '0', 03:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:44 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-YbMy4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:44 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-A24yJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:44 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-t1jJAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:44 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-YQ8YGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-0dV1wO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-rTSRRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-bOn3zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-veXeaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-4Ndh2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-f5P2qC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-qBnoEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-dFt6QG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ksf6dY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:45 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-lb7t1q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:46 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-ewtjwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:46 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-UheXMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:46 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-nu4NB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:13:46 INFO - Running setup.py install for manifestparser 03:13:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:13:46 INFO - Running setup.py install for mozcrash 03:13:46 INFO - Running setup.py install for mozdebug 03:13:46 INFO - Running setup.py install for mozdevice 03:13:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Running setup.py install for mozfile 03:13:47 INFO - Running setup.py install for mozhttpd 03:13:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Running setup.py install for mozinfo 03:13:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Running setup.py install for mozInstall 03:13:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Running setup.py install for mozleak 03:13:47 INFO - Running setup.py install for mozlog 03:13:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:13:47 INFO - Running setup.py install for moznetwork 03:13:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:13:48 INFO - Running setup.py install for mozprocess 03:13:48 INFO - Running setup.py install for mozprofile 03:13:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:13:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:13:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:13:48 INFO - Running setup.py install for mozrunner 03:13:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:13:48 INFO - Running setup.py install for mozscreenshot 03:13:48 INFO - Running setup.py install for moztest 03:13:48 INFO - Running setup.py install for mozversion 03:13:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:13:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:13:48 INFO - Cleaning up... 03:13:48 INFO - Return code: 0 03:13:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13:48 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')]} 03:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:48 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')]} 03:13:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:48 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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:48 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 03:13:48 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 03:13:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:48 INFO - 'HOME': '/Users/cltbld', 03:13:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:48 INFO - 'LOGNAME': 'cltbld', 03:13:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:48 INFO - 'MOZ_NO_REMOTE': '1', 03:13:48 INFO - 'NO_EM_RESTART': '1', 03:13:48 INFO - 'PAGER': '/bin/cat', 03:13:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:48 INFO - 'PWD': '/builds/slave/test', 03:13:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:48 INFO - 'SHELL': '/bin/bash', 03:13:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:48 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:48 INFO - 'USER': 'cltbld', 03:13:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:48 INFO - 'XPC_FLAGS': '0x0', 03:13:48 INFO - 'XPC_SERVICE_NAME': '0', 03:13:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-s2OLVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-6if2Rj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-5oMR5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-f3NaoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-CElz6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-LHSWJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:13:49 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-mrGLRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:13:49 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)) 03:13:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-LvUJSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-e7_BSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-vwuSaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-3NojgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-jT786y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-9TBxL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-fx1d3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:13:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-migPRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-JRD0Le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:13:50 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)) 03:13:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:13:50 INFO - Running setup.py (path:/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/pip-aVTJR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:13:51 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)) 03:13:51 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)) 03:13:51 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)) 03:13:51 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)) 03:13:51 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)) 03:13:51 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)) 03:13:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13: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 03:13:53 INFO - Downloading blessings-1.6.tar.gz 03:13:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:13:53 INFO - Installing collected packages: blessings 03:13:53 INFO - Running setup.py install for blessings 03:13:53 INFO - Successfully installed blessings 03:13:53 INFO - Cleaning up... 03:13:53 INFO - Return code: 0 03:13:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:13:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:54 INFO - Reading from file tmpfile_stdout 03:13:54 INFO - Current package versions: 03:13:54 INFO - blessings == 1.6 03:13:54 INFO - blobuploader == 1.2.4 03:13:54 INFO - docopt == 0.6.1 03:13:54 INFO - functools32 == 3.2.3-2 03:13:54 INFO - jsonschema == 2.5.1 03:13:54 INFO - manifestparser == 1.1 03:13:54 INFO - mozInstall == 1.12 03:13:54 INFO - mozcrash == 0.17 03:13:54 INFO - mozdebug == 0.1 03:13:54 INFO - mozdevice == 0.48 03:13:54 INFO - mozfile == 1.2 03:13:54 INFO - mozhttpd == 0.7 03:13:54 INFO - mozinfo == 0.9 03:13:54 INFO - mozleak == 0.1 03:13:54 INFO - mozlog == 3.2 03:13:54 INFO - moznetwork == 0.27 03:13:54 INFO - mozprocess == 0.23 03:13:54 INFO - mozprofile == 0.28 03:13:54 INFO - mozrunner == 6.12 03:13:54 INFO - mozscreenshot == 0.1 03:13:54 INFO - mozsystemmonitor == 0.3 03:13:54 INFO - moztest == 0.7 03:13:54 INFO - mozversion == 1.4 03:13:54 INFO - psutil == 3.1.1 03:13:54 INFO - requests == 1.2.3 03:13:54 INFO - wsgiref == 0.1.2 03:13:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13:54 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 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13:54 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 03:13:54 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 03:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:54 INFO - 'HOME': '/Users/cltbld', 03:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:54 INFO - 'LOGNAME': 'cltbld', 03:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:54 INFO - 'MOZ_NO_REMOTE': '1', 03:13:54 INFO - 'NO_EM_RESTART': '1', 03:13:54 INFO - 'PAGER': '/bin/cat', 03:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:54 INFO - 'PWD': '/builds/slave/test', 03:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:54 INFO - 'SHELL': '/bin/bash', 03:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:54 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:54 INFO - 'USER': 'cltbld', 03:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:54 INFO - 'XPC_FLAGS': '0x0', 03:13:54 INFO - 'XPC_SERVICE_NAME': '0', 03:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 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)) 03:13:54 INFO - Cleaning up... 03:13:54 INFO - Return code: 0 03:13:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:13: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')]} 03:13:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:13:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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')]} 03:13:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:13:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:13: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c6f2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c787618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9e91cb04f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, '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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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 03:13: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', 'jsonschema'] in /builds/slave/test/build 03:13: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 jsonschema 03:13:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:13:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:54 INFO - 'HOME': '/Users/cltbld', 03:13:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:54 INFO - 'LOGNAME': 'cltbld', 03:13:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:54 INFO - 'MOZ_NO_REMOTE': '1', 03:13:54 INFO - 'NO_EM_RESTART': '1', 03:13:54 INFO - 'PAGER': '/bin/cat', 03:13:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:54 INFO - 'PWD': '/builds/slave/test', 03:13:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:54 INFO - 'SHELL': '/bin/bash', 03:13:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:13:54 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:13:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:54 INFO - 'USER': 'cltbld', 03:13:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:54 INFO - 'XPC_FLAGS': '0x0', 03:13:54 INFO - 'XPC_SERVICE_NAME': '0', 03:13:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:13:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:13:54 INFO - Cleaning up... 03:13:54 INFO - Return code: 0 03:13:54 INFO - Running post-action listener: _resource_record_post_action 03:13:54 INFO - Running post-action listener: _start_resource_monitoring 03:13:54 INFO - Starting resource monitoring. 03:13:54 INFO - ##### 03:13:54 INFO - ##### Finished create-virtualenv step (success) 03:13:54 INFO - ##### 03:13:54 INFO - ##### 03:13:54 INFO - ##### Running install step. 03:13:54 INFO - ##### 03:13:54 INFO - Running pre-action listener: _resource_record_pre_action 03:13:54 INFO - Running main action method: install 03:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:13:54 INFO - Reading from file tmpfile_stdout 03:13:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:13:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:13:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:13:55 INFO - Reading from file tmpfile_stdout 03:13:55 INFO - Output received: 03:13:55 INFO - Usage: mozinstall [options] installer 03:13:55 INFO - Options: 03:13:55 INFO - -h, --help show this help message and exit 03:13:55 INFO - -d DEST, --destination=DEST 03:13:55 INFO - Directory to install application into. [default: 03:13:55 INFO - "/builds/slave/test"] 03:13:55 INFO - --app=APP Application being installed. [default: firefox] 03:13:55 INFO - mkdir: /builds/slave/test/build/application 03:13:55 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'] 03:13:55 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 03:14:29 INFO - Reading from file tmpfile_stdout 03:14:29 INFO - Output received: 03:14:29 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:14:29 INFO - Running post-action listener: _resource_record_post_action 03:14:29 INFO - ##### 03:14:29 INFO - ##### Finished install step (success) 03:14:29 INFO - ##### 03:14:29 INFO - ##### 03:14:29 INFO - ##### Running run-tests step. 03:14:29 INFO - ##### 03:14:29 INFO - Running pre-action listener: _resource_record_pre_action 03:14:29 INFO - Running main action method: run_tests 03:14:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:14:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:14:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:14:29 INFO - 2016-07-14 03:14:29.613 screenresolution[2005:278802] starting screenresolution argv=screenresolution get 03:14:29 INFO - 2016-07-14 03:14:29.615 screenresolution[2005:278802] Display 0: 1600x1200x32@60 03:14:29 INFO - 2016-07-14 03:14:29.621 screenresolution[2006:278804] starting screenresolution argv=screenresolution list 03:14:29 INFO - Available Modes on Display 0 03:14:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:14:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:14:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:14:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:14:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:14:29 INFO - Intel Iris: 03:14:29 INFO - Chipset Model: Intel Iris 03:14:29 INFO - Type: GPU 03:14:29 INFO - Bus: Built-In 03:14:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:14:29 INFO - Vendor: Intel (0x8086) 03:14:29 INFO - Device ID: 0x0a2e 03:14:29 INFO - Revision ID: 0x0009 03:14:29 INFO - Displays: 03:14:29 INFO - Display: 03:14:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:14:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:14:29 INFO - Display Serial Number: 1600x1200 60 03:14:29 INFO - Main Display: Yes 03:14:29 INFO - Mirror: Off 03:14:29 INFO - Online: Yes 03:14:29 INFO - Rotation: Supported 03:14:29 INFO - Return code: 0 03:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:14:29 INFO - Python 2.7.3 03:14:29 INFO - Return code: 0 03:14:29 INFO - grabbing minidump binary from tooltool 03:14:29 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')]} 03:14:29 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 0x10c656d30>, '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 0x10c3bbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c64eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:14:29 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 03:14:29 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 03:14:29 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 03:14:29 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:14:29 INFO - Return code: 0 03:14:29 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:14:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:14:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:14:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:14:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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 03:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0170 --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 03:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ib6hBEOxv3/Render', 03:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:14:29 INFO - 'HOME': '/Users/cltbld', 03:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:14:29 INFO - 'LOGNAME': 'cltbld', 03:14:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:14:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:29 INFO - 'MOZ_NO_REMOTE': '1', 03:14:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:14:29 INFO - 'NO_EM_RESTART': '1', 03:14:29 INFO - 'PAGER': '/bin/cat', 03:14:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:29 INFO - 'PWD': '/builds/slave/test', 03:14:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:14:29 INFO - 'SHELL': '/bin/bash', 03:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dtGkqquW8c/Listeners', 03:14:29 INFO - 'TMPDIR': '/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/', 03:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:14:29 INFO - 'USER': 'cltbld', 03:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:29 INFO - 'XPC_FLAGS': '0x0', 03:14:29 INFO - 'XPC_SERVICE_NAME': '0', 03:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:14:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0170', '--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 03:14:30 INFO - mozversion application_buildid: 20160714020544 03:14:30 INFO - mozversion application_changeset: cb1812acfcd1ed05706e0bd9405668d11516cfd4 03:14:30 INFO - mozversion application_display_name: Nightly 03:14:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:14:30 INFO - mozversion application_name: Firefox 03:14:30 INFO - mozversion application_remotingname: firefox 03:14:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:14:30 INFO - mozversion application_vendor: Mozilla 03:14:30 INFO - mozversion application_version: 50.0a1 03:14:30 INFO - mozversion platform_buildid: 20160714020544 03:14:30 INFO - mozversion platform_changeset: cb1812acfcd1ed05706e0bd9405668d11516cfd4 03:14:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:14:30 INFO - mozversion platform_version: 50.0a1 03:14:30 INFO - using testdate: 1468491270 03:14:30 INFO - actual date: 1468491270 03:14:30 INFO - starting webserver on 'localhost:49378' 03:14:30 INFO - SUITE-START | Running 2 tests 03:14:30 INFO - TEST-START | dromaeo_css 03:14:30 INFO - operating with platform_type : mac_ 03:14:30 INFO - Initialising browser for dromaeo_css test... 03:14:30 INFO - TEST-INFO | started process 2016 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpQ4CCAm/profile http://localhost:49378/getInfo.html) 03:14:33 INFO - PROCESS | 2016 | __metrics Screen width/height:1600/1200 03:14:33 INFO - PROCESS | 2016 | colorDepth:24 03:14:33 INFO - PROCESS | 2016 | Browser inner width/height: 1024/689 03:14:33 INFO - PROCESS | 2016 | __metrics 03:14:33 ERROR - PROCESS | 2016 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 03:14:34 INFO - TEST-INFO | 2016: exit 0 03:14:34 INFO - Browser initialized. 03:14:34 INFO - Running cycle 1/1 for dromaeo_css test... 03:14:34 INFO - TEST-INFO | started process 2021 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmpQ4CCAm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:14:46 INFO - PROCESS | 2021 | RSS: Main: 254394368 03:14:46 INFO - PROCESS | 2021 | 03:15:35 INFO - PROCESS | 2021 | 1468491335850 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] 03:17:46 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49378/tests/dromaeo/cssquery-ext.html) 03:17:48 INFO - PROCESS | 2021 | RSS: Main: 266895360 03:17:48 INFO - PROCESS | 2021 | 03:20:50 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-ext.html (next: http://localhost:49378/tests/dromaeo/cssquery-jquery.html) 03:20:51 INFO - PROCESS | 2021 | RSS: Main: 275521536 03:20:51 INFO - PROCESS | 2021 | 03:23:53 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49378/tests/dromaeo/cssquery-mootools.html) 03:23:53 INFO - PROCESS | 2021 | RSS: Main: 280096768 03:23:53 INFO - PROCESS | 2021 | 03:26:55 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49378/tests/dromaeo/cssquery-prototype.html) 03:26:56 INFO - PROCESS | 2021 | RSS: Main: 279535616 03:26:56 INFO - PROCESS | 2021 | 03:29:59 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49378/tests/dromaeo/cssquery-yui.html) 03:29:59 INFO - PROCESS | 2021 | RSS: Main: 282738688 03:29:59 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | Cycle 1(1): loaded http://localhost:49378/tests/dromaeo/cssquery-yui.html (next: http://localhost:49378/tests/dromaeo/cssquery-dojo.html) 03:33:02 INFO - PROCESS | 2021 | RSS: Main: 282902528 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | __start_tp_report 03:33:02 INFO - PROCESS | 2021 | _x_x_mozilla_page_load 03:33:02 INFO - PROCESS | 2021 | _x_x_mozilla_page_load_details 03:33:02 INFO - PROCESS | 2021 | |i|pagename|runs| 03:33:02 INFO - PROCESS | 2021 | |0;dojo.html;3394.5926488821337;3402.625711171769;3423.5891692996843;3425.6574342565746;3426.7258619310473;5871.670702179181;5879.441453061958;5954.255718035246;5988.490978266853;6019.849503762397;5786.784775197214;5885.999999999989;5902.468777809996;5924.763009479627;5965.46310832025;5238.92141617876;5304.018756530035;5383.892322153554;5393.946060539403;5449.891002179954;265.4880226795446;4847.539483749056;4939.851804445872;5269;5338.172583249602;5322.2548843161985;5322.866928326823;5340.225667278261;5362.517373436371;5364.839054828361;5357.383900851374;5404.756785944642;5416.539594134503;5422.213779002022;5445.591580631469;4493.887652808673;4899.975500122512;5218.478152184789;5305.734713264322;5381.0852155133725;5699.145128230757;5899.115132730125;5913.408659134052;5941.049432090845;5970.373110823388;6169.105479705462;6186.133941248228;6282.434580887696;6289.119523266746;6352.333005034451;6198.318184999646;6211.409916057967;6259.906101408483;6309.716062777186;6315;5209.765560549784;5992.221011268551;6010.429009244115;6033.4871535919065;6049.364816694272;6230.034344676583;6313.179286692793;6377.043443483514;6386.936130638727;6395.968020159962;6183.81448556544;6200.286966998853;6231.657258850716;6233.688315584202;6257.155284036688;6223.37766223374;6264.091706702503;6322.71547780351;6327.683615819191;6333.240011198685;5565.5825813063375;5984.311804142492;6147.616786223064;6237.438630523275;6263.123162757218;5130.589552835764;6203.503719702413;6228.4705800007505;6244.063390491463;6247.437730604177;4993.850184494471;5092.465291144451;5106.66806657566;5116.56509196715;5143.691378517301;4309.332053531708;4393.275109606943;4467.285234362486;4525.411696479502;4595.379623750818;5812.38969908162;5898.410158984153;6021.397860213943;6025.728842202024;6042.274927008787;6291.433770960635;6303.810885673345;6330.05049242608;6336.493080553637;6353.3329000455215;5871.207387002785;5970.432808883149;5976.402359763989;6001.759929602855;6027.9095813562835;5554.250176226238;5576.163575463713;5578.246936663499;5597.776088956396;5603.187537806995;6269.216347956505;6509.446697030806;6537.084808126961;6547.476201903932;6550.934490655032;4767.73777442244;5145.614078944169;5310.937812437451;6147.170132032118;6294.968525157528;6453.257875344396;6456.386643268882;6459.935400646122;6478.967605161944;6538.280789113099;6121.693915304128;6122.794608433986;6204.689765511616;6247.531435142291;6281.309056003927;5437.864053398696;6123.252118380239;6270.561060725706;6299.338569450325;6319.115323854756;6094.268687757498;6178.443940045418;6201.720922558586;6207.565470417208;6218.378162183745;5912.911306330322;6099.400579571985;6115.840394147502;6123.191113103653;6197.4732147767945;5977.372375900642;6110.072772100023;6112.144299798121;6139.487476704529;6144.078388241621;5715.714214289185;5907.847969645878;6222;6247.12540244357;6259.311475737756;5871.119332100219;5986.191864098465;6003.159557661844;6045.274567051982;6112.938870611237 03:33:02 INFO - PROCESS | 2021 | |1;ext.html;454.6998980672757;509.19292920720653;516.795865633075;540.3138014721304;572.8682403047296;30394.848025759868;41457.3781393279;41460.58539414605;41466.58533414665;41541.753747387585;41847.790761046155;42431.78784106083;42439.36340954888;42491.36262956058;42565.57434425655;9543.141117299441;9699.70900872975;9733.756656083584;9744.561494732754;9760.755981100458;9541.761455963622;9616.519174041305;9617.990111038345;9625.326227164102;9640.61437542501;9674.129328360446;9674.613015479372;9674.806503869919;9687.951560242189;9699.903000970005;9570.617175312978;9575.042495750438;9663.951680241555;9670.854937175913;9688.951555242178;8252.876206856901;9556.139947404767;9666.033396660348;9667.564959576835;9715.27135464843;39934.400983985266;40137.39793903094;40166;40304.59695403038;40404.393934091015;3215.903522894317;3464.7055000325004;3468.6357932417236;3516.578010638714;3579.8031108289033;28774.856125719445;30556.853543839363;31037.534436983464;31521.36957260842;32261;2988.4770165221;3142.4972004479173;3154.8738050477955;3258.625258095302;3274.4433446314183;481233;490513;490878;491572;492423;32919.341613167606;33160.834195828866;33198;33199.83400083033;33711;34082.82958585191;34159.829200853834;34161.487577686356;34623.480647790304;34642.48036279458;14953.327100280514;15242.466513671969;15291.847081529264;15326.923365383102;15347.693046139015;12990.220586764824;13032.54386096501;13099;13101.737965240642;13178.736425271441;7077.009218709385;7619.733309334147;7622.123455802543;7676.771716525329;7694.038245219348;2993.925151871221;3246.6753324667816;3248.691374319436;3252.219467327824;3267.0525547591405;899.7795540092719;914.6752902719438;969.3408482232009;1014.6195176808696;1043.2905624175482;30539.8473007638;30669.38661226763;30683.69316306853;30731.846340768152;31331.060068197992;1012.4684540616236;1042.3954106618144;1069.946502674863;1076.5424694504961;1106.9944650276698;16091;16140.43508477221;16189.757153642704;16386.590335241475;16552;724219;771693;786458;788160;790220;60691;60698.39301607016;61471.69264153651;61514.0772888407;61664;1402.0816365280757;1412.5621057472217;1416.2847761880184;1421.2822524625205;1422.6870088580495;30918.0724578263;31635.683643164193;31876.840615796773;32004.51993220057;32063.67936320607;51372;51624.22563661473;52106.739466302424;52358;52381.69045773886;665896;672381.638091826;672437;673663;678447;27233.72766272312;27679.584806227518;27703.722962770113;28209.576856347583;28433;49514.00971980468;49667.25499117588;50207;50294.748526257135;50818.491815081376;39740.602593973694;40715.38926916039;41306.1738765217;41603.583964159974;41607.167856643304;41232.79383603183;41858;42212.577874220864;42667.57332426636;43335.56664433315;38832.02919927025;39582.208355833296;39884.80057599693;39916.80041599889;40013.599864000986;34775;35049.31982141839;36126.458103129;36295.818520907225;36488.27023459569;25395;26156.34609134787;26357;26384.340391490365;26715.33211669646 03:33:02 INFO - PROCESS | 2021 | |2;jquery.html;343.9157406435423;352.8165354015912;374.1469449654787;386.7486134012891;399.7441637352093;17817.821821781778;18238.726419103707;20681.482962925933;21245.68131478029;21678.89160554195;11763.294202347864;12097.09271804616;12224;12293.569725059624;12329.568465103723;4744.193487107192;5654.802081927133;5664.631798933056;5686.943130568683;5688.544916406699;3956.9604303957026;4940.777665005084;6164.352742961969;6182.5981311214855;6253.218347706536;5751.4248575142365;6218.502519798428;6234.625922444668;6248.968755156217;6267.122602835607;6032.457078862902;6043.546733994968;6123;6133.26400831903;6155.876882462326;5968.731407086691;6035.486983606399;6056.424639659225;6101.816945491642;6109.816705498798;13480.932595337059;13706.903447724158;24463.755362446325;25326.873365633055;26000.34999125018;2407.5546023985617;2514.748525147489;2527.494501099769;2833.7307955744172;2999.2801727585443;10298.17614590831;10416.635417760343;10417.947910260476;10493.79012419755;10651;1568.5764843492193;1852.786929503111;1901.0969789350086;1922.7692676878864;1934.535711429261;115843.42078289638;125411;127084.45831083326;127855;128367;11613.6515904523;11750.29498230109;11758.941205293919;11829.940850295694;11831.194052950255;14556.344964476624;14614;14679.48621798232;14698.191599462132;14701.26493675312;8831.3376496763;8896.955515222382;8904.554772261361;8916.955415222883;8977.46135231875;8932.151445612657;8949.328800340001;8960.103989601119;9019.503927283931;9083.000869904305;3906.570277269498;4559.772011399416;4615.930761038587;4620.861374158781;4660.97669511657;1782.7415024821587;3373.1229880231317;3639.3994990826745;3849.9230015399535;3911.4328422378594;810.2262339465796;883.4699180491654;935.4527601353149;943.3115620481573;956.8660387545749;20458.181672733223;20819.895900520703;21696.783032169475;21887.343379698636;22176.445588860086;914.3873604684877;932.0632764072064;975.2246963663763;992.925530585209;1051.6792378324685;8137.147652515351;11047.779044419067;11476.770464590829;11630.302181869114;11827.112966527546;603049;603266;629591;631520;636363;138673.999999998;139392.3030384862;145015;149041;150481;998.6205242008135;1048.1928914735763;1048.1981284317503;1064.292245656645;1067.1196263082832;19511.70732439043;20127.194912203347;20132.698009530162;20157.294494692615;20401.08195131193;57925;57956.4204357951;58657.70671146617;59234.70382648059;60261.69869150626;86338.56830715806;86830;87474;87640;88208.5589572048;7265.854682906206;7515.09818821723;7611.847763044819;8321.459105158145;8502;9480.431174129575;13292.40184191733;13770.24263665508;13980.510682126076;14187.716245675236;11814.704632384259;11969.521219151486;12038.217515861441;12056.63830085099;12080.697982550506;11497.022753066083;11790.646280611596;11797.997170240626;11876.82184767212;12039.578614748441;9749.220062395134;12126.181072839145;12150.57472988441;12162.513499460276;12280.570180043656;8043.919560804551;8160.387970902325;8188.263056324721;8284.31299176251;8355.832883342178;8217.630206640595;10415.583376664848;11837.526498939946;11863.406829658656;11886.16796824214 03:33:02 INFO - PROCESS | 2021 | |3;mootools.html;1478.4899209772627;1556.79761630988;1794.7128459446492;1913.1868955693826;1926.8651194416395;8155.225253600914;8725.607347669355;8737.694180703676;9175.082491750822;9180.357374983745;8709.303255739542;8744;8804.383693141483;8945.55272236389;8957.686480973167;2012.9798702013013;2348.941276468085;2367.6566897799808;2372.51363470489;2382.975320612136;2327.9185228517003;2358.304300231427;2366.715994080713;2370.596998510249;2374.5013547155118;2330.6853574767442;2341.9531609367887;2346.401667574766;2350.4006478347997;2376;2321.7446080931086;2323.7908588227056;2342.051469154995;2348.906043758256;2355.328731311568;2328.7438381777993;2340.075670110297;2340.6137987232087;2344.7069116360453;2345.0736958901307;8859.379843410963;8861.379703420764;8964.924209094885;8982.191602755784;9004.189622933902;5295.311609490742;5306.681599104028;5408.621396502246;5450.5367043801325;5457.808976685797;3596.694280986093;3661.0847288177956;3719.3863012602887;3738.9626103738888;3742.7567208131386;962.8651988721584;1073.3291692692067;1081.9134469242442;1096.0957210301453;1100.0429626225155;9440.914294856111;11352.2621029632;11848.466818993165;11860.466279017464;11896.345700986441;3998.980005099956;4033.979830100831;4616.930746038812;4632.2819962905805;4862.562369386772;8878.778030549289;9913.65302214419;10087.546060427298;10158.238132140119;10159.593616255266;5219.451957544479;5408.945910540923;5442.374126975448;5451.863703407367;5462.044142275086;4338.436003319548;4762.9523704763205;4964.702117872867;4968.403791545038;4987.80048798044;3994.960050399517;4011.338129208706;4067.2678917795083;4125.133721918431;4132.710710250314;1276.7765641012786;1289.2908900105092;1296.7082406458471;1304.7977563477675;1305.3538498443331;916.2990312411011;926.8980412154658;936.4334577580465;954.7756277274835;993.60752502761;4696.624270058455;6006.039033754579;6120.602160859619;6190.659513726789;6205.6586887721605;370.5904975002637;417.1510975165584;432.6646848692289;447.55021203690734;448.8451484237998;3741.0273328934672;3791.469194312798;4034.45534852797;4210.305299625588;4358.171947329997;10820.24258301927;10873.021428071512;11165.553377864957;11203.831942520868;11214.046806021579;10607.098396636218;10888.237823352289;11129.666110016713;11147.609833655782;11162.441877906072;8297.12880147588;8437.114103019094;8509.510835603745;8533.402661813738;8549.957250213834;6162.630242185483;6185.134081228542;6338.746450142127;6356.396142366468;6421.8073457796345;10205.897941020496;10268.743281418025;10334.512369962747;10366.896331036593;10443.843342349719;10230.181585472996;10355.171586272929;10503.107235885036;10533.736656583647;10554.102901253173;7154.570725756471;7616.8476630465975;7783.727569535039;7836.960815195887;7953.403494738033;8557.957210213908;8681.609327580149;8691.869621955802;8772.868406974028;8782.121787821166;7552.546847189186;7684.961575192088;7711.460197786101;7798;7813.921860781319;7489.325960663567;7575.24247575238;7575.659095340613;7684.807879803049;7700.691972321044;7130.465215108991;7266.890996634949;7314.926850731425;7320.377767889576;7322.450816188701;4306.978465107654;4961.156603377507;5157.252198431132;5172.069027575073;5211.661242019257;5124.5131712487255;5184.896302074013;5238.895222095613;5328.774381892109;5333.280007199133 03:33:02 INFO - PROCESS | 2021 | |4;prototype.html;281.2392478346074;315.14438300015456;322.7031131359148;323.94169049571076;325.29248883677997;5344.0915044442445;5427.755750991205;5716.914246286298;5718.370979192291;5731.168980497825;5596.664200147994;5603.971980140093;5616.634918730279;5639.546797143235;5692.8861422771515;3154.3533575617057;3441.4493681011045;3698.8890333290046;4018;4083.530394004683;4241.787910604473;4285.164392943378;4323.200207961521;4327.32926396409;4327.956720432802;4280.871573852789;4284.314509678452;4284.635805956497;4291.549387314334;4321.157374312011;4130.070734084822;4249.553796851317;4256.021115143534;4271.594198551133;4278.6363159131515;3292.720118789906;3435.7974708851953;3696.7597106188014;3704.4258139988347;3708.610595887447;4764.141984625999;5414.810481633124;5450.400455949843;5484.8354549363585;5503.3120859892515;4369.300911854088;4722.291656251589;4765.26138448541;4792.616590672773;4960.404751429815;5119.846404607868;5372.683692495325;5883.294004719461;5926.377730338296;5955.332506898076;3550.236699109678;3791.658750712449;3991.6607088397523;4117.993864478917;4125.257453658341;5207.661502002357;5409.702466364349;5914.467697907209;6152.8769424611255;6206.317305096481;3222.951655725166;3745.250949810049;4137.77242251673;4142.813573389205;4161.52142503616;3703.648168418508;3727.8071017274756;4018.0758425562285;4240.448741663564;4241.384999175164;4078.2659121358442;4505.256632655575;4947.6289278304275;4950.455449900508;4977.527134922177;5109.9744501278;5888.587798854125;5984;6018.969905150446;6031.517478601701;1377.579838149354;1383.1148065238256;1396.6801372702698;1401.7314330530885;1413.074436244241;850.9702160424356;867.9262262707614;869.8042940338499;874.3180319350917;907.9319051071196;4744;5196.92204616931;5284.867878303073;5450.781968721286;5476.67139971603;5380.677159370451;5602.1512900742655;5867.20792692981;5950.953351720871;6028.216331876915;4546.681732278708;5242.80189084658;5406.729663516887;5416.377116631559;5431.646942948696;2749.0790585154195;3131.7024882636115;3136.4197623439736;3152.684731526829;3168.3663267346624;4731.266653668687;5562.3881373048935;5633.774649013993;5855.238818953509;6297.1813664223355;5960.437012084759;6374.458171055419;6420.550561460653;6443.806685799434;6445.001024841157;6437.903431448438;6439.388258115565;6439.420452159328;6468.989226679395;6478.805635830932;5135.537801597874;5826.271716035496;6077.787277445268;6133.723982420713;6134.2332208473945;5307.283516725192;5605.943940560543;5631.436856314336;6157.538184636081;6175.9073613894925;6093.156035612203;6319.842003949938;6334.524910631813;6418.293987661447;6477.935220647733;3555.3600351935866;3578.964210357863;3806.8096595170687;3879.9418008729326;4040.17176478827;5872.823815285548;6181.752729890754;6228.5951413158;6251.124842521959;6260.7495700171485;5409.513143816918;5690.231818704422;5967.850803729942;6069.757209711562;6078.908816367846;4942.3080768693135;5439.782408703608;5472.634329887171;6043.939560604338;6052.606580572248;5559.832435188656;5893.823185304448;5933.169356290209;5938.287405511366;5960.552958528041;4935.629827763004;5797.275340582427;5977.551683623833;5992.310884248192;5993.011153159854;5831.533477321719;5866.384029676822;5897.026990546683;5902.586818922634;5916.254704862162 03:33:02 INFO - PROCESS | 2021 | |5;yui.html;690.6788343420309;710.1939298895753;755.3579457461159;766.6435107674931;842.8735689646549;15095.320710568023;15269.312880920357;15353.232338383092;15733.763993540091;15854.445094421697;14277.286135693199;14354.138751674907;14362.712745745079;14364.712705745878;14375.568732938002;880.4937161132359;903.9502827344494;937.1284705224139;939.976500587484;941.4210260689661;918.554501066982;923.4920793563547;929.4794914847673;931.1107891963193;931.7018554062669;954.2318433660901;966.6761634852332;966.8211380894522;968.6319198704482;969.6654654144309;946;949.0130264524886;956.063058202965;958.2956526952685;960.5053397500258;718.3391280022392;720.2653293640458;720.6036679826075;721.239092757141;721.4444877444339;15910.920445397815;15994.040357578582;16040.598985025468;16041;16059.678806423806;12730.745385092247;14434.85565144356;14623.78064329036;14689.412423503047;15008.324625391884;11868.584599538975;12252.81620775689;12481.625551233477;12498.812517812241;12567.497300107985;3816.6183381661613;3831.4252862070634;4016.256992456405;4039.1315867088424;4042.4340592316803;116651;118701;121131.39434302771;121727.3913630435;121739;11035.889641103648;11113.333200008025;11355.54577816878;11453.828192577119;11579.305241685357;22630.886845565998;23237.07051717946;23252.883735581552;23254.837258137024;23276.95253713587;7938.483998540192;7959.442839001214;8030.156833532395;8100.3519718422385;8329.625166867385;4367.432233809584;4379.430674012358;4563.931541026887;4575.565321294472;4653.95346046542;3579.3736096183584;3680.3743363628246;3693.169036966715;3704.6480584344445;3707.94438083429;663.3830537600078;668.4819265069513;672.4653900149393;688.900109484132;690.6063543779998;569.9971500142473;574.2907509226102;606.75123199488;625.9123722678829;660.1846719301659;9620.518974051269;9627.374220675634;9786.461744604116;10017.098461138532;10096.495175241209;538.9811356602579;661.84777501175;668.4618881800101;680.6771050385935;708.8936659501013;4181.393697913785;4775.928361074587;4780.235162374073;4786.95213047865;4840.927386089212;106251;125772.1134182988;134917.32541337426;137376;140991;91629.62555561672;130151.34924325507;132075;132303;135322.29355412838;69798;76515;93760;112020.43989780163;112765;10028.949855250678;10290.434026128634;10331.173506119341;10340.948295258777;10367.896321036693;53186.2022069677;64920.67539662271;66264.00603990848;66648.66675666785;66753.66623166853;88866;93966.53016734873;97989;101724;103987.4800625992;11396.202265841312;11804.17370784037;12135.878641213474;12317.44571494267;13830.65423364424;13106.410211540313;13546.661333466347;14789.260536973323;15316.463923762614;15955.122468264357;14061.578152655436;14246.35891384911;14481.92759036198;14500.371931564592;14641.48754793577;12124.939375303067;13858.722825543231;14426.242552641063;14649.194294313915;14934.402623894923;13995.370208340446;14111.929440352733;14125.364358603681;14315.427382904567;14818.703625927206;11302.717432063935;11493.266404873908;11615.593454229062;11826.172167948162;11858;9728.854067189139;10834.729131771768;11410.600628977945;11815.940920295343;12466.937665311616 03:33:02 INFO - PROCESS | 2021 | __end_tp_report 03:33:02 INFO - PROCESS | 2021 | __start_cc_report 03:33:02 INFO - PROCESS | 2021 | _x_x_mozilla_cycle_collect,433 03:33:02 INFO - PROCESS | 2021 | __end_cc_report 03:33:02 INFO - PROCESS | 2021 | __startTimestamp1468492382431__endTimestamp 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | ------- Summary: start ------- 03:33:02 INFO - PROCESS | 2021 | Number of tests: 6 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | [#0] dojo.html Cycles:165 Average:5767.16 Median:6019.85 stddev:781.21 (13.0%) stddev-sans-first:761.11 03:33:02 INFO - PROCESS | 2021 | Values: 3394.6 3402.6 3423.6 3425.7 3426.7 5871.7 5879.4 5954.3 5988.5 6019.8 5786.8 5886.0 5902.5 5924.8 5965.5 5238.9 5304.0 5383.9 5393.9 5449.9 265.5 4847.5 4939.9 5269.0 5338.2 5322.3 5322.9 5340.2 5362.5 5364.8 5357.4 5404.8 5416.5 5422.2 5445.6 4493.9 4900.0 5218.5 5305.7 5381.1 5699.1 5899.1 5913.4 5941.0 5970.4 6169.1 6186.1 6282.4 6289.1 6352.3 6198.3 6211.4 6259.9 6309.7 6315.0 5209.8 5992.2 6010.4 6033.5 6049.4 6230.0 6313.2 6377.0 6386.9 6396.0 6183.8 6200.3 6231.7 6233.7 6257.2 6223.4 6264.1 6322.7 6327.7 6333.2 5565.6 5984.3 6147.6 6237.4 6263.1 5130.6 6203.5 6228.5 6244.1 6247.4 4993.9 5092.5 5106.7 5116.6 5143.7 4309.3 4393.3 4467.3 4525.4 4595.4 5812.4 5898.4 6021.4 6025.7 6042.3 6291.4 6303.8 6330.1 6336.5 6353.3 5871.2 5970.4 5976.4 6001.8 6027.9 5554.3 5576.2 5578.2 5597.8 5603.2 6269.2 6509.4 6537.1 6547.5 6550.9 4767.7 5145.6 5310.9 6147.2 6295.0 6453.3 6456.4 6459.9 6479.0 6538.3 6121.7 6122.8 6204.7 6247.5 6281.3 5437.9 6123.3 6270.6 6299.3 6319.1 6094.3 6178.4 6201.7 6207.6 6218.4 5912.9 6099.4 6115.8 6123.2 6197.5 5977.4 6110.1 6112.1 6139.5 6144.1 5715.7 5907.8 6222.0 6247.1 6259.3 5871.1 5986.2 6003.2 6045.3 6112.9 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | [#1] ext.html Cycles:180 Average:75183.70 Median:40151.70 stddev:176343.50 (439.2%) stddev-sans-first:176748.93 03:33:02 INFO - PROCESS | 2021 | Values: 454.7 509.2 516.8 540.3 572.9 30394.8 41457.4 41460.6 41466.6 41541.8 41847.8 42431.8 42439.4 42491.4 42565.6 9543.1 9699.7 9733.8 9744.6 9760.8 9541.8 9616.5 9618.0 9625.3 9640.6 9674.1 9674.6 9674.8 9688.0 9699.9 9570.6 9575.0 9664.0 9670.9 9689.0 8252.9 9556.1 9666.0 9667.6 9715.3 39934.4 40137.4 40166.0 40304.6 40404.4 3215.9 3464.7 3468.6 3516.6 3579.8 28774.9 30556.9 31037.5 31521.4 32261.0 2988.5 3142.5 3154.9 3258.6 3274.4 481233.0 490513.0 490878.0 491572.0 492423.0 32919.3 33160.8 33198.0 33199.8 33711.0 34082.8 34159.8 34161.5 34623.5 34642.5 14953.3 15242.5 15291.8 15326.9 15347.7 12990.2 13032.5 13099.0 13101.7 13178.7 7077.0 7619.7 7622.1 7676.8 7694.0 2993.9 3246.7 3248.7 3252.2 3267.1 899.8 914.7 969.3 1014.6 1043.3 30539.8 30669.4 30683.7 30731.8 31331.1 1012.5 1042.4 1069.9 1076.5 1107.0 16091.0 16140.4 16189.8 16386.6 16552.0 724219.0 771693.0 786458.0 788160.0 790220.0 60691.0 60698.4 61471.7 61514.1 61664.0 1402.1 1412.6 1416.3 1421.3 1422.7 30918.1 31635.7 31876.8 32004.5 32063.7 51372.0 51624.2 52106.7 52358.0 52381.7 665896.0 672381.6 672437.0 673663.0 678447.0 27233.7 27679.6 27703.7 28209.6 28433.0 49514.0 49667.3 50207.0 50294.7 50818.5 39740.6 40715.4 41306.2 41603.6 41607.2 41232.8 41858.0 42212.6 42667.6 43335.6 38832.0 39582.2 39884.8 39916.8 40013.6 34775.0 35049.3 36126.5 36295.8 36488.3 25395.0 26156.3 26357.0 26384.3 26715.3 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | [#2] jquery.html Cycles:180 Average:36561.06 Median:2916.51 stddev:104200.88 (3572.8%) stddev-sans-first:104457.71 03:33:02 INFO - PROCESS | 2021 | Values: 343.9 352.8 374.1 386.7 399.7 17817.8 18238.7 20681.5 21245.7 21678.9 11763.3 12097.1 12224.0 12293.6 12329.6 4744.2 5654.8 5664.6 5686.9 5688.5 3957.0 4940.8 6164.4 6182.6 6253.2 5751.4 6218.5 6234.6 6249.0 6267.1 6032.5 6043.5 6123.0 6133.3 6155.9 5968.7 6035.5 6056.4 6101.8 6109.8 13480.9 13706.9 24463.8 25326.9 26000.3 2407.6 2514.7 2527.5 2833.7 2999.3 10298.2 10416.6 10417.9 10493.8 10651.0 1568.6 1852.8 1901.1 1922.8 1934.5 115843.4 125411.0 127084.5 127855.0 128367.0 11613.7 11750.3 11758.9 11829.9 11831.2 14556.3 14614.0 14679.5 14698.2 14701.3 8831.3 8897.0 8904.6 8917.0 8977.5 8932.2 8949.3 8960.1 9019.5 9083.0 3906.6 4559.8 4615.9 4620.9 4661.0 1782.7 3373.1 3639.4 3849.9 3911.4 810.2 883.5 935.5 943.3 956.9 20458.2 20819.9 21696.8 21887.3 22176.4 914.4 932.1 975.2 992.9 1051.7 8137.1 11047.8 11476.8 11630.3 11827.1 603049.0 603266.0 629591.0 631520.0 636363.0 138674.0 139392.3 145015.0 149041.0 150481.0 998.6 1048.2 1048.2 1064.3 1067.1 19511.7 20127.2 20132.7 20157.3 20401.1 57925.0 57956.4 58657.7 59234.7 60261.7 86338.6 86830.0 87474.0 87640.0 88208.6 7265.9 7515.1 7611.8 8321.5 8502.0 9480.4 13292.4 13770.2 13980.5 14187.7 11814.7 11969.5 12038.2 12056.6 12080.7 11497.0 11790.6 11798.0 11876.8 12039.6 9749.2 12126.2 12150.6 12162.5 12280.6 8043.9 8160.4 8188.3 8284.3 8355.8 8217.6 10415.6 11837.5 11863.4 11886.2 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | [#3] mootools.html Cycles:180 Average:5810.74 Median:4624.61 stddev:3291.79 (71.2%) stddev-sans-first:3284.93 03:33:02 INFO - PROCESS | 2021 | Values: 1478.5 1556.8 1794.7 1913.2 1926.9 8155.2 8725.6 8737.7 9175.1 9180.4 8709.3 8744.0 8804.4 8945.6 8957.7 2013.0 2348.9 2367.7 2372.5 2383.0 2327.9 2358.3 2366.7 2370.6 2374.5 2330.7 2342.0 2346.4 2350.4 2376.0 2321.7 2323.8 2342.1 2348.9 2355.3 2328.7 2340.1 2340.6 2344.7 2345.1 8859.4 8861.4 8964.9 8982.2 9004.2 5295.3 5306.7 5408.6 5450.5 5457.8 3596.7 3661.1 3719.4 3739.0 3742.8 962.9 1073.3 1081.9 1096.1 1100.0 9440.9 11352.3 11848.5 11860.5 11896.3 3999.0 4034.0 4616.9 4632.3 4862.6 8878.8 9913.7 10087.5 10158.2 10159.6 5219.5 5408.9 5442.4 5451.9 5462.0 4338.4 4763.0 4964.7 4968.4 4987.8 3995.0 4011.3 4067.3 4125.1 4132.7 1276.8 1289.3 1296.7 1304.8 1305.4 916.3 926.9 936.4 954.8 993.6 4696.6 6006.0 6120.6 6190.7 6205.7 370.6 417.2 432.7 447.6 448.8 3741.0 3791.5 4034.5 4210.3 4358.2 10820.2 10873.0 11165.6 11203.8 11214.0 10607.1 10888.2 11129.7 11147.6 11162.4 8297.1 8437.1 8509.5 8533.4 8550.0 6162.6 6185.1 6338.7 6356.4 6421.8 10205.9 10268.7 10334.5 10366.9 10443.8 10230.2 10355.2 10503.1 10533.7 10554.1 7154.6 7616.8 7783.7 7837.0 7953.4 8558.0 8681.6 8691.9 8772.9 8782.1 7552.5 7685.0 7711.5 7798.0 7813.9 7489.3 7575.2 7575.7 7684.8 7700.7 7130.5 7266.9 7314.9 7320.4 7322.5 4307.0 4961.2 5157.3 5172.1 5211.7 5124.5 5184.9 5238.9 5328.8 5333.3 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | [#4] prototype.html Cycles:180 Average:4780.98 Median:5415.59 stddev:1512.74 (27.9%) stddev-sans-first:1478.80 03:33:02 INFO - PROCESS | 2021 | Values: 281.2 315.1 322.7 323.9 325.3 5344.1 5427.8 5716.9 5718.4 5731.2 5596.7 5604.0 5616.6 5639.5 5692.9 3154.4 3441.4 3698.9 4018.0 4083.5 4241.8 4285.2 4323.2 4327.3 4328.0 4280.9 4284.3 4284.6 4291.5 4321.2 4130.1 4249.6 4256.0 4271.6 4278.6 3292.7 3435.8 3696.8 3704.4 3708.6 4764.1 5414.8 5450.4 5484.8 5503.3 4369.3 4722.3 4765.3 4792.6 4960.4 5119.8 5372.7 5883.3 5926.4 5955.3 3550.2 3791.7 3991.7 4118.0 4125.3 5207.7 5409.7 5914.5 6152.9 6206.3 3223.0 3745.3 4137.8 4142.8 4161.5 3703.6 3727.8 4018.1 4240.4 4241.4 4078.3 4505.3 4947.6 4950.5 4977.5 5110.0 5888.6 5984.0 6019.0 6031.5 1377.6 1383.1 1396.7 1401.7 1413.1 851.0 867.9 869.8 874.3 907.9 4744.0 5196.9 5284.9 5450.8 5476.7 5380.7 5602.2 5867.2 5951.0 6028.2 4546.7 5242.8 5406.7 5416.4 5431.6 2749.1 3131.7 3136.4 3152.7 3168.4 4731.3 5562.4 5633.8 5855.2 6297.2 5960.4 6374.5 6420.6 6443.8 6445.0 6437.9 6439.4 6439.4 6469.0 6478.8 5135.5 5826.3 6077.8 6133.7 6134.2 5307.3 5605.9 5631.4 6157.5 6175.9 6093.2 6319.8 6334.5 6418.3 6477.9 3555.4 3579.0 3806.8 3879.9 4040.2 5872.8 6181.8 6228.6 6251.1 6260.7 5409.5 5690.2 5967.9 6069.8 6078.9 4942.3 5439.8 5472.6 6043.9 6052.6 5559.8 5893.8 5933.2 5938.3 5960.6 4935.6 5797.3 5977.6 5992.3 5993.0 5831.5 5866.4 5897.0 5902.6 5916.3 03:33:02 INFO - PROCESS | 2021 | 03:33:02 INFO - PROCESS | 2021 | [#5] yui.html Cycles:180 Average:24405.24 Median:23244.98 stddev:37859.09 (162.9%) stddev-sans-first:37923.42 03:33:02 INFO - PROCESS | 2021 | Values: 690.7 710.2 755.4 766.6 842.9 15095.3 15269.3 15353.2 15733.8 15854.4 14277.3 14354.1 14362.7 14364.7 14375.6 880.5 904.0 937.1 940.0 941.4 918.6 923.5 929.5 931.1 931.7 954.2 966.7 966.8 968.6 969.7 946.0 949.0 956.1 958.3 960.5 718.3 720.3 720.6 721.2 721.4 15910.9 15994.0 16040.6 16041.0 16059.7 12730.7 14434.9 14623.8 14689.4 15008.3 11868.6 12252.8 12481.6 12498.8 12567.5 3816.6 3831.4 4016.3 4039.1 4042.4 116651.0 118701.0 121131.4 121727.4 121739.0 11035.9 11113.3 11355.5 11453.8 11579.3 22630.9 23237.1 23252.9 23254.8 23277.0 7938.5 7959.4 8030.2 8100.4 8329.6 4367.4 4379.4 4563.9 4575.6 4654.0 3579.4 3680.4 3693.2 3704.6 3707.9 663.4 668.5 672.5 688.9 690.6 570.0 574.3 606.8 625.9 660.2 9620.5 9627.4 9786.5 10017.1 10096.5 539.0 661.8 668.5 680.7 708.9 4181.4 4775.9 4780.2 4787.0 4840.9 106251.0 125772.1 134917.3 137376.0 140991.0 91629.6 130151.3 132075.0 132303.0 135322.3 69798.0 76515.0 93760.0 112020.4 112765.0 10028.9 10290.4 10331.2 10340.9 10367.9 53186.2 64920.7 66264.0 66648.7 66753.7 88866.0 93966.5 97989.0 101724.0 103987.5 11396.2 11804.2 12135.9 12317.4 13830.7 13106.4 13546.7 14789.3 15316.5 15955.1 14061.6 14246.4 14481.9 14500.4 14641.5 12124.9 13858.7 14426.2 14649.2 14934.4 13995.4 14111.9 14125.4 14315.4 14818.7 11302.7 11493.3 11615.6 11826.2 11858.0 9728.9 10834.7 11410.6 11815.9 12466.9 03:33:02 INFO - PROCESS | 2021 | -------- Summary: end -------- 03:33:02 INFO - PROCESS | 2021 | 03:33:03 INFO - TEST-INFO | 2021: exit 0 03:33:03 INFO - TEST-OK | dromaeo_css | took 1112858ms 03:33:03 INFO - TEST-START | kraken 03:33:03 INFO - operating with platform_type : mac_ 03:33:03 INFO - Initialising browser for kraken test... 03:33:03 INFO - TEST-INFO | started process 2029 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp4rUj3L/profile http://localhost:49378/getInfo.html) 03:33:06 INFO - PROCESS | 2029 | __metrics Screen width/height:1600/1200 03:33:06 INFO - PROCESS | 2029 | colorDepth:24 03:33:06 INFO - PROCESS | 2029 | Browser inner width/height: 1024/689 03:33:06 INFO - PROCESS | 2029 | __metrics 03:33:06 ERROR - PROCESS | 2029 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 03:33:06 INFO - TEST-INFO | 2029: exit 0 03:33:06 INFO - Browser initialized. 03:33:06 INFO - Running cycle 1/1 for kraken test... 03:33:06 INFO - TEST-INFO | started process 2031 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/T/tmp4rUj3L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:19 INFO - PROCESS | 2031 | RSS: Main: 254525440 03:33:19 INFO - PROCESS | 2031 | 03:33:21 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-beat-detection) 03:33:22 INFO - PROCESS | 2031 | RSS: Main: 267231232 03:33:22 INFO - PROCESS | 2031 | 03:33:25 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-dft) 03:33:26 INFO - PROCESS | 2031 | RSS: Main: 271679488 03:33:26 INFO - PROCESS | 2031 | 03:33:29 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-fft) 03:33:30 INFO - PROCESS | 2031 | RSS: Main: 271650816 03:33:30 INFO - PROCESS | 2031 | 03:33:32 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49378/tests/kraken/driver.html?testName=audio-oscillator) 03:33:33 INFO - PROCESS | 2031 | RSS: Main: 272674816 03:33:33 INFO - PROCESS | 2031 | 03:33:35 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49378/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:33:35 INFO - PROCESS | 2031 | RSS: Main: 273104896 03:33:35 INFO - PROCESS | 2031 | 03:33:38 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49378/tests/kraken/driver.html?testName=imaging-darkroom) 03:33:39 INFO - PROCESS | 2031 | RSS: Main: 273793024 03:33:39 INFO - PROCESS | 2031 | 03:33:42 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49378/tests/kraken/driver.html?testName=imaging-desaturate) 03:33:42 INFO - PROCESS | 2031 | RSS: Main: 274169856 03:33:42 INFO - PROCESS | 2031 | 03:33:46 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49378/tests/kraken/driver.html?testName=json-parse-financial) 03:33:46 INFO - PROCESS | 2031 | RSS: Main: 274161664 03:33:46 INFO - PROCESS | 2031 | 03:33:48 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49378/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:33:48 INFO - PROCESS | 2031 | RSS: Main: 273686528 03:33:48 INFO - PROCESS | 2031 | 03:33:50 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:33:51 INFO - PROCESS | 2031 | RSS: Main: 273694720 03:33:51 INFO - PROCESS | 2031 | 03:33:53 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:33:54 INFO - PROCESS | 2031 | RSS: Main: 273977344 03:33:54 INFO - PROCESS | 2031 | 03:33:57 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:33:57 INFO - PROCESS | 2031 | RSS: Main: 274124800 03:33:57 INFO - PROCESS | 2031 | 03:34:00 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:34:01 INFO - PROCESS | 2031 | RSS: Main: 273993728 03:34:01 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | Cycle 1(1): loaded http://localhost:49378/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49378/tests/kraken/driver.html?testName=ai-astar) 03:34:03 INFO - PROCESS | 2031 | RSS: Main: 274849792 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | __start_tp_report 03:34:03 INFO - PROCESS | 2031 | _x_x_mozilla_page_load 03:34:03 INFO - PROCESS | 2031 | _x_x_mozilla_page_load_details 03:34:03 INFO - PROCESS | 2031 | |i|pagename|runs| 03:34:03 INFO - PROCESS | 2031 | |0;ai-astar;103;116;107;116;117;116;130;171;164;118 03:34:03 INFO - PROCESS | 2031 | |1;audio-beat-detection;162;139;169;161;111;138;151;137;202;110 03:34:03 INFO - PROCESS | 2031 | |2;audio-dft;199;212;280;274;279;198;272;278;199;230 03:34:03 INFO - PROCESS | 2031 | |3;audio-fft;94;117;105;145;58;61;60;64;143;86 03:34:03 INFO - PROCESS | 2031 | |4;audio-oscillator;70;75;125;71;73;83;115;69;72;117 03:34:03 INFO - PROCESS | 2031 | |5;imaging-gaussian-blur;87;90;90;78;137;86;88;87;90;87 03:34:03 INFO - PROCESS | 2031 | |6;imaging-darkroom;95;99;149;98;94;105;95;98;96;96 03:34:03 INFO - PROCESS | 2031 | |7;imaging-desaturate;103;91;147;135;90;110;145;90;92;99 03:34:03 INFO - PROCESS | 2031 | |8;json-parse-financial;56;56;57;57;55;68;55;55;55;58 03:34:03 INFO - PROCESS | 2031 | |9;json-stringify-tinderbox;69;73;76;111;83;85;68;69;92;104 03:34:03 INFO - PROCESS | 2031 | |10;stanford-crypto-aes;83;82;77;79;84;92;77;102;107;105 03:34:03 INFO - PROCESS | 2031 | |11;stanford-crypto-ccm;136;137;141;142;138;147;143;138;205;160 03:34:03 INFO - PROCESS | 2031 | |12;stanford-crypto-pbkdf2;170;168;194;155;203;223;211;165;167;165 03:34:03 INFO - PROCESS | 2031 | |13;stanford-crypto-sha256-iterative;65;68;67;65;72;68;67;68;66;68 03:34:03 INFO - PROCESS | 2031 | __end_tp_report 03:34:03 INFO - PROCESS | 2031 | __start_cc_report 03:34:03 INFO - PROCESS | 2031 | _x_x_mozilla_cycle_collect,1124 03:34:03 INFO - PROCESS | 2031 | __end_cc_report 03:34:03 INFO - PROCESS | 2031 | __startTimestamp1468492443444__endTimestamp 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | ------- Summary: start ------- 03:34:03 INFO - PROCESS | 2031 | Number of tests: 14 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#0] ai-astar Cycles:10 Average:125.80 Median:117.50 stddev:23.14 (19.7%) stddev-sans-first:23.03 03:34:03 INFO - PROCESS | 2031 | Values: 103.0 116.0 107.0 116.0 117.0 116.0 130.0 171.0 164.0 118.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#1] audio-beat-detection Cycles:10 Average:148.00 Median:156.00 stddev:27.58 (17.7%) stddev-sans-first:28.78 03:34:03 INFO - PROCESS | 2031 | Values: 162.0 139.0 169.0 161.0 111.0 138.0 151.0 137.0 202.0 110.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#2] audio-dft Cycles:10 Average:242.10 Median:273.00 stddev:37.58 (13.8%) stddev-sans-first:36.48 03:34:03 INFO - PROCESS | 2031 | Values: 199.0 212.0 280.0 274.0 279.0 198.0 272.0 278.0 199.0 230.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#3] audio-fft Cycles:10 Average:93.30 Median:60.50 stddev:33.59 (55.5%) stddev-sans-first:35.62 03:34:03 INFO - PROCESS | 2031 | Values: 94.0 117.0 105.0 145.0 58.0 61.0 60.0 64.0 143.0 86.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:71.50 stddev:22.55 (31.5%) stddev-sans-first:23.07 03:34:03 INFO - PROCESS | 2031 | Values: 70.0 75.0 125.0 71.0 73.0 83.0 115.0 69.0 72.0 117.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#5] imaging-gaussian-blur Cycles:10 Average:92.00 Median:87.50 stddev:16.19 (18.5%) stddev-sans-first:17.07 03:34:03 INFO - PROCESS | 2031 | Values: 87.0 90.0 90.0 78.0 137.0 86.0 88.0 87.0 90.0 87.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:96.00 stddev:16.63 (17.3%) stddev-sans-first:17.42 03:34:03 INFO - PROCESS | 2031 | Values: 95.0 99.0 149.0 98.0 94.0 105.0 95.0 98.0 96.0 96.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#7] imaging-desaturate Cycles:10 Average:110.20 Median:90.00 stddev:23.27 (25.9%) stddev-sans-first:24.54 03:34:03 INFO - PROCESS | 2031 | Values: 103.0 91.0 147.0 135.0 90.0 110.0 145.0 90.0 92.0 99.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.50 stddev:3.94 (7.0%) stddev-sans-first:4.15 03:34:03 INFO - PROCESS | 2031 | Values: 56.0 56.0 57.0 57.0 55.0 68.0 55.0 55.0 55.0 58.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#9] json-stringify-tinderbox Cycles:10 Average:83.00 Median:74.50 stddev:15.19 (20.4%) stddev-sans-first:15.24 03:34:03 INFO - PROCESS | 2031 | Values: 69.0 73.0 76.0 111.0 83.0 85.0 68.0 69.0 92.0 104.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:80.50 stddev:11.81 (14.7%) stddev-sans-first:12.34 03:34:03 INFO - PROCESS | 2031 | Values: 83.0 82.0 77.0 79.0 84.0 92.0 77.0 102.0 107.0 105.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:142.50 stddev:20.99 (14.7%) stddev-sans-first:21.75 03:34:03 INFO - PROCESS | 2031 | Values: 136.0 137.0 141.0 142.0 138.0 147.0 143.0 138.0 205.0 160.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:182.00 stddev:23.52 (12.9%) stddev-sans-first:24.54 03:34:03 INFO - PROCESS | 2031 | Values: 170.0 168.0 194.0 155.0 203.0 223.0 211.0 165.0 167.0 165.0 03:34:03 INFO - PROCESS | 2031 | 03:34:03 INFO - PROCESS | 2031 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:2.01 (3.0%) stddev-sans-first:1.94 03:34:03 INFO - PROCESS | 2031 | Values: 65.0 68.0 67.0 65.0 72.0 68.0 67.0 68.0 66.0 68.0 03:34:03 INFO - PROCESS | 2031 | -------- Summary: end -------- 03:34:03 INFO - PROCESS | 2031 | 03:34:04 INFO - TEST-INFO | 2031: exit 0 03:34:04 INFO - TEST-OK | kraken | took 61220ms 03:34:04 INFO - SUITE-END | took 1174s 03:34:04 INFO - Completed test suite (00:19:34) 03:34:04 INFO - javascript benchmark 03:34:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7418.040023968968, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3394.5926488821337, 3402.625711171769, 3423.5891692996843, 3425.6574342565746, 3426.7258619310473, 5871.670702179181, 5879.441453061958, 5954.255718035246, 5988.490978266853, 6019.849503762397, 5786.784775197214, 5885.999999999989, 5902.468777809996, 5924.763009479627, 5965.46310832025, 5238.92141617876, 5304.018756530035, 5383.892322153554, 5393.946060539403, 5449.891002179954, 265.4880226795446, 4847.539483749056, 4939.851804445872, 5269.0, 5338.172583249602, 5322.2548843161985, 5322.866928326823, 5340.225667278261, 5362.517373436371, 5364.839054828361, 5357.383900851374, 5404.756785944642, 5416.539594134503, 5422.213779002022, 5445.591580631469, 4493.887652808673, 4899.975500122512, 5218.478152184789, 5305.734713264322, 5381.0852155133725, 5699.145128230757, 5899.115132730125, 5913.408659134052, 5941.049432090845, 5970.373110823388, 6169.105479705462, 6186.133941248228, 6282.434580887696, 6289.119523266746, 6352.333005034451, 6198.318184999646, 6211.409916057967, 6259.906101408483, 6309.716062777186, 6315.0, 5209.765560549784, 5992.221011268551, 6010.429009244115, 6033.4871535919065, 6049.364816694272, 6230.034344676583, 6313.179286692793, 6377.043443483514, 6386.936130638727, 6395.968020159962, 6183.81448556544, 6200.286966998853, 6231.657258850716, 6233.688315584202, 6257.155284036688, 6223.37766223374, 6264.091706702503, 6322.71547780351, 6327.683615819191, 6333.240011198685, 5565.5825813063375, 5984.311804142492, 6147.616786223064, 6237.438630523275, 6263.123162757218, 5130.589552835764, 6203.503719702413, 6228.4705800007505, 6244.063390491463, 6247.437730604177, 4993.850184494471, 5092.465291144451, 5106.66806657566, 5116.56509196715, 5143.691378517301, 4309.332053531708, 4393.275109606943, 4467.285234362486, 4525.411696479502, 4595.379623750818, 5812.38969908162, 5898.410158984153, 6021.397860213943, 6025.728842202024, 6042.274927008787, 6291.433770960635, 6303.810885673345, 6330.05049242608, 6336.493080553637, 6353.3329000455215, 5871.207387002785, 5970.432808883149, 5976.402359763989, 6001.759929602855, 6027.9095813562835, 5554.250176226238, 5576.163575463713, 5578.246936663499, 5597.776088956396, 5603.187537806995, 6269.216347956505, 6509.446697030806, 6537.084808126961, 6547.476201903932, 6550.934490655032, 4767.73777442244, 5145.614078944169, 5310.937812437451, 6147.170132032118, 6294.968525157528, 6453.257875344396, 6456.386643268882, 6459.935400646122, 6478.967605161944, 6538.280789113099, 6121.693915304128, 6122.794608433986, 6204.689765511616, 6247.531435142291, 6281.309056003927, 5437.864053398696, 6123.252118380239, 6270.561060725706, 6299.338569450325, 6319.115323854756, 6094.268687757498, 6178.443940045418, 6201.720922558586, 6207.565470417208, 6218.378162183745, 5912.911306330322, 6099.400579571985, 6115.840394147502, 6123.191113103653, 6197.4732147767945, 5977.372375900642, 6110.072772100023, 6112.144299798121, 6139.487476704529, 6144.078388241621, 5715.714214289185, 5907.847969645878, 6222.0, 6247.12540244357, 6259.311475737756, 5871.119332100219, 5986.191864098465, 6003.159557661844, 6045.274567051982, 6112.938870611237], "value": 5719.493374785225, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [454.6998980672757, 509.19292920720653, 516.795865633075, 540.3138014721304, 572.8682403047296, 30394.848025759868, 41457.3781393279, 41460.58539414605, 41466.58533414665, 41541.753747387585, 41847.790761046155, 42431.78784106083, 42439.36340954888, 42491.36262956058, 42565.57434425655, 9543.141117299441, 9699.70900872975, 9733.756656083584, 9744.561494732754, 9760.755981100458, 9541.761455963622, 9616.519174041305, 9617.990111038345, 9625.326227164102, 9640.61437542501, 9674.129328360446, 9674.613015479372, 9674.806503869919, 9687.951560242189, 9699.903000970005, 9570.617175312978, 9575.042495750438, 9663.951680241555, 9670.854937175913, 9688.951555242178, 8252.876206856901, 9556.139947404767, 9666.033396660348, 9667.564959576835, 9715.27135464843, 39934.400983985266, 40137.39793903094, 40166.0, 40304.59695403038, 40404.393934091015, 3215.903522894317, 3464.7055000325004, 3468.6357932417236, 3516.578010638714, 3579.8031108289033, 28774.856125719445, 30556.853543839363, 31037.534436983464, 31521.36957260842, 32261.0, 2988.4770165221, 3142.4972004479173, 3154.8738050477955, 3258.625258095302, 3274.4433446314183, 481233.0, 490513.0, 490878.0, 491572.0, 492423.0, 32919.341613167606, 33160.834195828866, 33198.0, 33199.83400083033, 33711.0, 34082.82958585191, 34159.829200853834, 34161.487577686356, 34623.480647790304, 34642.48036279458, 14953.327100280514, 15242.466513671969, 15291.847081529264, 15326.923365383102, 15347.693046139015, 12990.220586764824, 13032.54386096501, 13099.0, 13101.737965240642, 13178.736425271441, 7077.009218709385, 7619.733309334147, 7622.123455802543, 7676.771716525329, 7694.038245219348, 2993.925151871221, 3246.6753324667816, 3248.691374319436, 3252.219467327824, 3267.0525547591405, 899.7795540092719, 914.6752902719438, 969.3408482232009, 1014.6195176808696, 1043.2905624175482, 30539.8473007638, 30669.38661226763, 30683.69316306853, 30731.846340768152, 31331.060068197992, 1012.4684540616236, 1042.3954106618144, 1069.946502674863, 1076.5424694504961, 1106.9944650276698, 16091.0, 16140.43508477221, 16189.757153642704, 16386.590335241475, 16552.0, 724219.0, 771693.0, 786458.0, 788160.0, 790220.0, 60691.0, 60698.39301607016, 61471.69264153651, 61514.0772888407, 61664.0, 1402.0816365280757, 1412.5621057472217, 1416.2847761880184, 1421.2822524625205, 1422.6870088580495, 30918.0724578263, 31635.683643164193, 31876.840615796773, 32004.51993220057, 32063.67936320607, 51372.0, 51624.22563661473, 52106.739466302424, 52358.0, 52381.69045773886, 665896.0, 672381.638091826, 672437.0, 673663.0, 678447.0, 27233.72766272312, 27679.584806227518, 27703.722962770113, 28209.576856347583, 28433.0, 49514.00971980468, 49667.25499117588, 50207.0, 50294.748526257135, 50818.491815081376, 39740.602593973694, 40715.38926916039, 41306.1738765217, 41603.583964159974, 41607.167856643304, 41232.79383603183, 41858.0, 42212.577874220864, 42667.57332426636, 43335.56664433315, 38832.02919927025, 39582.208355833296, 39884.80057599693, 39916.80041599889, 40013.599864000986, 34775.0, 35049.31982141839, 36126.458103129, 36295.818520907225, 36488.27023459569, 25395.0, 26156.34609134787, 26357.0, 26384.340391490365, 26715.33211669646], "value": 18889.17880804114, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.9157406435423, 352.8165354015912, 374.1469449654787, 386.7486134012891, 399.7441637352093, 17817.821821781778, 18238.726419103707, 20681.482962925933, 21245.68131478029, 21678.89160554195, 11763.294202347864, 12097.09271804616, 12224.0, 12293.569725059624, 12329.568465103723, 4744.193487107192, 5654.802081927133, 5664.631798933056, 5686.943130568683, 5688.544916406699, 3956.9604303957026, 4940.777665005084, 6164.352742961969, 6182.5981311214855, 6253.218347706536, 5751.4248575142365, 6218.502519798428, 6234.625922444668, 6248.968755156217, 6267.122602835607, 6032.457078862902, 6043.546733994968, 6123.0, 6133.26400831903, 6155.876882462326, 5968.731407086691, 6035.486983606399, 6056.424639659225, 6101.816945491642, 6109.816705498798, 13480.932595337059, 13706.903447724158, 24463.755362446325, 25326.873365633055, 26000.34999125018, 2407.5546023985617, 2514.748525147489, 2527.494501099769, 2833.7307955744172, 2999.2801727585443, 10298.17614590831, 10416.635417760343, 10417.947910260476, 10493.79012419755, 10651.0, 1568.5764843492193, 1852.786929503111, 1901.0969789350086, 1922.7692676878864, 1934.535711429261, 115843.42078289638, 125411.0, 127084.45831083326, 127855.0, 128367.0, 11613.6515904523, 11750.29498230109, 11758.941205293919, 11829.940850295694, 11831.194052950255, 14556.344964476624, 14614.0, 14679.48621798232, 14698.191599462132, 14701.26493675312, 8831.3376496763, 8896.955515222382, 8904.554772261361, 8916.955415222883, 8977.46135231875, 8932.151445612657, 8949.328800340001, 8960.103989601119, 9019.503927283931, 9083.000869904305, 3906.570277269498, 4559.772011399416, 4615.930761038587, 4620.861374158781, 4660.97669511657, 1782.7415024821587, 3373.1229880231317, 3639.3994990826745, 3849.9230015399535, 3911.4328422378594, 810.2262339465796, 883.4699180491654, 935.4527601353149, 943.3115620481573, 956.8660387545749, 20458.181672733223, 20819.895900520703, 21696.783032169475, 21887.343379698636, 22176.445588860086, 914.3873604684877, 932.0632764072064, 975.2246963663763, 992.925530585209, 1051.6792378324685, 8137.147652515351, 11047.779044419067, 11476.770464590829, 11630.302181869114, 11827.112966527546, 603049.0, 603266.0, 629591.0, 631520.0, 636363.0, 138673.999999998, 139392.3030384862, 145015.0, 149041.0, 150481.0, 998.6205242008135, 1048.1928914735763, 1048.1981284317503, 1064.292245656645, 1067.1196263082832, 19511.70732439043, 20127.194912203347, 20132.698009530162, 20157.294494692615, 20401.08195131193, 57925.0, 57956.4204357951, 58657.70671146617, 59234.70382648059, 60261.69869150626, 86338.56830715806, 86830.0, 87474.0, 87640.0, 88208.5589572048, 7265.854682906206, 7515.09818821723, 7611.847763044819, 8321.459105158145, 8502.0, 9480.431174129575, 13292.40184191733, 13770.24263665508, 13980.510682126076, 14187.716245675236, 11814.704632384259, 11969.521219151486, 12038.217515861441, 12056.63830085099, 12080.697982550506, 11497.022753066083, 11790.646280611596, 11797.997170240626, 11876.82184767212, 12039.578614748441, 9749.220062395134, 12126.181072839145, 12150.57472988441, 12162.513499460276, 12280.570180043656, 8043.919560804551, 8160.387970902325, 8188.263056324721, 8284.31299176251, 8355.832883342178, 8217.630206640595, 10415.583376664848, 11837.526498939946, 11863.406829658656, 11886.16796824214], "value": 9803.41183781201, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.4899209772627, 1556.79761630988, 1794.7128459446492, 1913.1868955693826, 1926.8651194416395, 8155.225253600914, 8725.607347669355, 8737.694180703676, 9175.082491750822, 9180.357374983745, 8709.303255739542, 8744.0, 8804.383693141483, 8945.55272236389, 8957.686480973167, 2012.9798702013013, 2348.941276468085, 2367.6566897799808, 2372.51363470489, 2382.975320612136, 2327.9185228517003, 2358.304300231427, 2366.715994080713, 2370.596998510249, 2374.5013547155118, 2330.6853574767442, 2341.9531609367887, 2346.401667574766, 2350.4006478347997, 2376.0, 2321.7446080931086, 2323.7908588227056, 2342.051469154995, 2348.906043758256, 2355.328731311568, 2328.7438381777993, 2340.075670110297, 2340.6137987232087, 2344.7069116360453, 2345.0736958901307, 8859.379843410963, 8861.379703420764, 8964.924209094885, 8982.191602755784, 9004.189622933902, 5295.311609490742, 5306.681599104028, 5408.621396502246, 5450.5367043801325, 5457.808976685797, 3596.694280986093, 3661.0847288177956, 3719.3863012602887, 3738.9626103738888, 3742.7567208131386, 962.8651988721584, 1073.3291692692067, 1081.9134469242442, 1096.0957210301453, 1100.0429626225155, 9440.914294856111, 11352.2621029632, 11848.466818993165, 11860.466279017464, 11896.345700986441, 3998.980005099956, 4033.979830100831, 4616.930746038812, 4632.2819962905805, 4862.562369386772, 8878.778030549289, 9913.65302214419, 10087.546060427298, 10158.238132140119, 10159.593616255266, 5219.451957544479, 5408.945910540923, 5442.374126975448, 5451.863703407367, 5462.044142275086, 4338.436003319548, 4762.9523704763205, 4964.702117872867, 4968.403791545038, 4987.80048798044, 3994.960050399517, 4011.338129208706, 4067.2678917795083, 4125.133721918431, 4132.710710250314, 1276.7765641012786, 1289.2908900105092, 1296.7082406458471, 1304.7977563477675, 1305.3538498443331, 916.2990312411011, 926.8980412154658, 936.4334577580465, 954.7756277274835, 993.60752502761, 4696.624270058455, 6006.039033754579, 6120.602160859619, 6190.659513726789, 6205.6586887721605, 370.5904975002637, 417.1510975165584, 432.6646848692289, 447.55021203690734, 448.8451484237998, 3741.0273328934672, 3791.469194312798, 4034.45534852797, 4210.305299625588, 4358.171947329997, 10820.24258301927, 10873.021428071512, 11165.553377864957, 11203.831942520868, 11214.046806021579, 10607.098396636218, 10888.237823352289, 11129.666110016713, 11147.609833655782, 11162.441877906072, 8297.12880147588, 8437.114103019094, 8509.510835603745, 8533.402661813738, 8549.957250213834, 6162.630242185483, 6185.134081228542, 6338.746450142127, 6356.396142366468, 6421.8073457796345, 10205.897941020496, 10268.743281418025, 10334.512369962747, 10366.896331036593, 10443.843342349719, 10230.181585472996, 10355.171586272929, 10503.107235885036, 10533.736656583647, 10554.102901253173, 7154.570725756471, 7616.8476630465975, 7783.727569535039, 7836.960815195887, 7953.403494738033, 8557.957210213908, 8681.609327580149, 8691.869621955802, 8772.868406974028, 8782.121787821166, 7552.546847189186, 7684.961575192088, 7711.460197786101, 7798.0, 7813.921860781319, 7489.325960663567, 7575.24247575238, 7575.659095340613, 7684.807879803049, 7700.691972321044, 7130.465215108991, 7266.890996634949, 7314.926850731425, 7320.377767889576, 7322.450816188701, 4306.978465107654, 4961.156603377507, 5157.252198431132, 5172.069027575073, 5211.661242019257, 5124.5131712487255, 5184.896302074013, 5238.895222095613, 5328.774381892109, 5333.280007199133], "value": 4571.811363210727, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.2392478346074, 315.14438300015456, 322.7031131359148, 323.94169049571076, 325.29248883677997, 5344.0915044442445, 5427.755750991205, 5716.914246286298, 5718.370979192291, 5731.168980497825, 5596.664200147994, 5603.971980140093, 5616.634918730279, 5639.546797143235, 5692.8861422771515, 3154.3533575617057, 3441.4493681011045, 3698.8890333290046, 4018.0, 4083.530394004683, 4241.787910604473, 4285.164392943378, 4323.200207961521, 4327.32926396409, 4327.956720432802, 4280.871573852789, 4284.314509678452, 4284.635805956497, 4291.549387314334, 4321.157374312011, 4130.070734084822, 4249.553796851317, 4256.021115143534, 4271.594198551133, 4278.6363159131515, 3292.720118789906, 3435.7974708851953, 3696.7597106188014, 3704.4258139988347, 3708.610595887447, 4764.141984625999, 5414.810481633124, 5450.400455949843, 5484.8354549363585, 5503.3120859892515, 4369.300911854088, 4722.291656251589, 4765.26138448541, 4792.616590672773, 4960.404751429815, 5119.846404607868, 5372.683692495325, 5883.294004719461, 5926.377730338296, 5955.332506898076, 3550.236699109678, 3791.658750712449, 3991.6607088397523, 4117.993864478917, 4125.257453658341, 5207.661502002357, 5409.702466364349, 5914.467697907209, 6152.8769424611255, 6206.317305096481, 3222.951655725166, 3745.250949810049, 4137.77242251673, 4142.813573389205, 4161.52142503616, 3703.648168418508, 3727.8071017274756, 4018.0758425562285, 4240.448741663564, 4241.384999175164, 4078.2659121358442, 4505.256632655575, 4947.6289278304275, 4950.455449900508, 4977.527134922177, 5109.9744501278, 5888.587798854125, 5984.0, 6018.969905150446, 6031.517478601701, 1377.579838149354, 1383.1148065238256, 1396.6801372702698, 1401.7314330530885, 1413.074436244241, 850.9702160424356, 867.9262262707614, 869.8042940338499, 874.3180319350917, 907.9319051071196, 4744.0, 5196.92204616931, 5284.867878303073, 5450.781968721286, 5476.67139971603, 5380.677159370451, 5602.1512900742655, 5867.20792692981, 5950.953351720871, 6028.216331876915, 4546.681732278708, 5242.80189084658, 5406.729663516887, 5416.377116631559, 5431.646942948696, 2749.0790585154195, 3131.7024882636115, 3136.4197623439736, 3152.684731526829, 3168.3663267346624, 4731.266653668687, 5562.3881373048935, 5633.774649013993, 5855.238818953509, 6297.1813664223355, 5960.437012084759, 6374.458171055419, 6420.550561460653, 6443.806685799434, 6445.001024841157, 6437.903431448438, 6439.388258115565, 6439.420452159328, 6468.989226679395, 6478.805635830932, 5135.537801597874, 5826.271716035496, 6077.787277445268, 6133.723982420713, 6134.2332208473945, 5307.283516725192, 5605.943940560543, 5631.436856314336, 6157.538184636081, 6175.9073613894925, 6093.156035612203, 6319.842003949938, 6334.524910631813, 6418.293987661447, 6477.935220647733, 3555.3600351935866, 3578.964210357863, 3806.8096595170687, 3879.9418008729326, 4040.17176478827, 5872.823815285548, 6181.752729890754, 6228.5951413158, 6251.124842521959, 6260.7495700171485, 5409.513143816918, 5690.231818704422, 5967.850803729942, 6069.757209711562, 6078.908816367846, 4942.3080768693135, 5439.782408703608, 5472.634329887171, 6043.939560604338, 6052.606580572248, 5559.832435188656, 5893.823185304448, 5933.169356290209, 5938.287405511366, 5960.552958528041, 4935.629827763004, 5797.275340582427, 5977.551683623833, 5992.310884248192, 5993.011153159854, 5831.533477321719, 5866.384029676822, 5897.026990546683, 5902.586818922634, 5916.254704862162], "value": 4292.016836198153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.6788343420309, 710.1939298895753, 755.3579457461159, 766.6435107674931, 842.8735689646549, 15095.320710568023, 15269.312880920357, 15353.232338383092, 15733.763993540091, 15854.445094421697, 14277.286135693199, 14354.138751674907, 14362.712745745079, 14364.712705745878, 14375.568732938002, 880.4937161132359, 903.9502827344494, 937.1284705224139, 939.976500587484, 941.4210260689661, 918.554501066982, 923.4920793563547, 929.4794914847673, 931.1107891963193, 931.7018554062669, 954.2318433660901, 966.6761634852332, 966.8211380894522, 968.6319198704482, 969.6654654144309, 946.0, 949.0130264524886, 956.063058202965, 958.2956526952685, 960.5053397500258, 718.3391280022392, 720.2653293640458, 720.6036679826075, 721.239092757141, 721.4444877444339, 15910.920445397815, 15994.040357578582, 16040.598985025468, 16041.0, 16059.678806423806, 12730.745385092247, 14434.85565144356, 14623.78064329036, 14689.412423503047, 15008.324625391884, 11868.584599538975, 12252.81620775689, 12481.625551233477, 12498.812517812241, 12567.497300107985, 3816.6183381661613, 3831.4252862070634, 4016.256992456405, 4039.1315867088424, 4042.4340592316803, 116651.0, 118701.0, 121131.39434302771, 121727.3913630435, 121739.0, 11035.889641103648, 11113.333200008025, 11355.54577816878, 11453.828192577119, 11579.305241685357, 22630.886845565998, 23237.07051717946, 23252.883735581552, 23254.837258137024, 23276.95253713587, 7938.483998540192, 7959.442839001214, 8030.156833532395, 8100.3519718422385, 8329.625166867385, 4367.432233809584, 4379.430674012358, 4563.931541026887, 4575.565321294472, 4653.95346046542, 3579.3736096183584, 3680.3743363628246, 3693.169036966715, 3704.6480584344445, 3707.94438083429, 663.3830537600078, 668.4819265069513, 672.4653900149393, 688.900109484132, 690.6063543779998, 569.9971500142473, 574.2907509226102, 606.75123199488, 625.9123722678829, 660.1846719301659, 9620.518974051269, 9627.374220675634, 9786.461744604116, 10017.098461138532, 10096.495175241209, 538.9811356602579, 661.84777501175, 668.4618881800101, 680.6771050385935, 708.8936659501013, 4181.393697913785, 4775.928361074587, 4780.235162374073, 4786.95213047865, 4840.927386089212, 106251.0, 125772.1134182988, 134917.32541337426, 137376.0, 140991.0, 91629.62555561672, 130151.34924325507, 132075.0, 132303.0, 135322.29355412838, 69798.0, 76515.0, 93760.0, 112020.43989780163, 112765.0, 10028.949855250678, 10290.434026128634, 10331.173506119341, 10340.948295258777, 10367.896321036693, 53186.2022069677, 64920.67539662271, 66264.00603990848, 66648.66675666785, 66753.66623166853, 88866.0, 93966.53016734873, 97989.0, 101724.0, 103987.4800625992, 11396.202265841312, 11804.17370784037, 12135.878641213474, 12317.44571494267, 13830.65423364424, 13106.410211540313, 13546.661333466347, 14789.260536973323, 15316.463923762614, 15955.122468264357, 14061.578152655436, 14246.35891384911, 14481.92759036198, 14500.371931564592, 14641.48754793577, 12124.939375303067, 13858.722825543231, 14426.242552641063, 14649.194294313915, 14934.402623894923, 13995.370208340446, 14111.929440352733, 14125.364358603681, 14315.427382904567, 14818.703625927206, 11302.717432063935, 11493.266404873908, 11615.593454229062, 11826.172167948162, 11858.0, 9728.854067189139, 10834.729131771768, 11410.600628977945, 11815.940920295343, 12466.937665311616], "value": 8016.690814594723, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1628.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 107.0, 116.0, 117.0, 116.0, 130.0, 171.0, 164.0, 118.0], "value": 125.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 139.0, 169.0, 161.0, 111.0, 138.0, 151.0, 137.0, 202.0, 110.0], "value": 148.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 212.0, 280.0, 274.0, 279.0, 198.0, 272.0, 278.0, 199.0, 230.0], "value": 242.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 117.0, 105.0, 145.0, 58.0, 61.0, 60.0, 64.0, 143.0, 86.0], "value": 93.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 125.0, 71.0, 73.0, 83.0, 115.0, 69.0, 72.0, 117.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 90.0, 78.0, 137.0, 86.0, 88.0, 87.0, 90.0, 87.0], "value": 92.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 99.0, 149.0, 98.0, 94.0, 105.0, 95.0, 98.0, 96.0, 96.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 91.0, 147.0, 135.0, 90.0, 110.0, 145.0, 90.0, 92.0, 99.0], "value": 110.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 55.0, 68.0, 55.0, 55.0, 55.0, 58.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 73.0, 76.0, 111.0, 83.0, 85.0, 68.0, 69.0, 92.0, 104.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 77.0, 79.0, 84.0, 92.0, 77.0, 102.0, 107.0, 105.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 141.0, 142.0, 138.0, 147.0, 143.0, 138.0, 205.0, 160.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 194.0, 155.0, 203.0, 223.0, 211.0, 165.0, 167.0, 165.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 65.0, 72.0, 68.0, 67.0, 68.0, 66.0, 68.0], "value": 67.4, "unit": "score"}]}]} 03:34:04 INFO - Return code: 0 03:34:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:34:04 ERROR - # TBPL SUCCESS # 03:34:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:34:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:34:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:34:04 INFO - 2016-07-14 03:34:04.791 screenresolution[2036:281524] starting screenresolution argv=screenresolution get 03:34:04 INFO - 2016-07-14 03:34:04.793 screenresolution[2036:281524] Display 0: 1600x1200x32@60 03:34:04 INFO - 2016-07-14 03:34:04.799 screenresolution[2037:281527] starting screenresolution argv=screenresolution list 03:34:04 INFO - Available Modes on Display 0 03:34:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:34:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:34:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:34:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:34:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:34:05 INFO - Intel Iris: 03:34:05 INFO - Chipset Model: Intel Iris 03:34:05 INFO - Type: GPU 03:34:05 INFO - Bus: Built-In 03:34:05 INFO - VRAM (Dynamic, Max): 1536 MB 03:34:05 INFO - Vendor: Intel (0x8086) 03:34:05 INFO - Device ID: 0x0a2e 03:34:05 INFO - Revision ID: 0x0009 03:34:05 INFO - Displays: 03:34:05 INFO - Display: 03:34:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:34:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:34:05 INFO - Display Serial Number: 1600x1200 60 03:34:05 INFO - Main Display: Yes 03:34:05 INFO - Mirror: Off 03:34:05 INFO - Online: Yes 03:34:05 INFO - Rotation: Supported 03:34:05 INFO - Return code: 0 03:34:05 INFO - Running post-action listener: _resource_record_post_action 03:34:05 INFO - ##### 03:34:05 INFO - ##### Finished run-tests step (success) 03:34:05 INFO - ##### 03:34:05 INFO - Running post-run listener: _resource_record_post_run 03:34:05 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 8036352; Write bytes: 704972800; Read time: 81; Write time: 1869 03:34:05 INFO - TinderboxPrint: CPU usage
54.2% 03:34:05 INFO - TinderboxPrint: I/O read bytes / time
8,036,352 / 81 03:34:05 INFO - TinderboxPrint: I/O write bytes / time
704,972,800 / 1,869 03:34:05 INFO - TinderboxPrint: CPU idle
2,213.9 (45.8%) 03:34:05 INFO - TinderboxPrint: CPU system
975.6 (20.2%) 03:34:05 INFO - TinderboxPrint: CPU user
1,648.0 (34.1%) 03:34:05 INFO - TinderboxPrint: Swap in / out
424,718,336 / 0 03:34:05 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 388176384; Write bytes: 383072256; Read time: 29405; Write time: 723 03:34:05 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 8036352; Write bytes: 294637568; Read time: 81; Write time: 1093 03:34:05 INFO - Running post-run listener: _upload_blobber_files 03:34:05 INFO - Blob upload gear active. 03:34:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:34:05 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 03:34:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:34:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:34:05 INFO - (blobuploader) - INFO - Open directory for files ... 03:34:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:34:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:34:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:06 INFO - (blobuploader) - INFO - Done attempting. 03:34:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:34:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:34:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:08 INFO - (blobuploader) - INFO - Done attempting. 03:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:34:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:10 INFO - (blobuploader) - INFO - Done attempting. 03:34:10 INFO - (blobuploader) - INFO - Iteration through files over. 03:34:10 INFO - Return code: 0 03:34:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:34:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:34:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1bffbd982b3165813b837dace39eb6c0f4a6d7cdecd9572b3811fa3781ae7569148d91c4bc87e4331dec0524577d7014bc6452994bbe6e812393ae86f165eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a14e54ba207eddc0659986e0efa4fd10bbf5247f8fe62283d7c0d2e0b9bb51d36588e623a0688372aeb9bb9e95cff8c260b92651f575a1f9d9cf687308c60082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7c17eb6d763f7e160833cde85bc3ac206360683d794eff1c2474ea7813e6329b74a59c7531a2e88a1b0380571dc75f83053d432fbf2e27885315634f78ebfa24"} 03:34:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:34:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:34:10 INFO - Contents: 03:34:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1bffbd982b3165813b837dace39eb6c0f4a6d7cdecd9572b3811fa3781ae7569148d91c4bc87e4331dec0524577d7014bc6452994bbe6e812393ae86f165eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a14e54ba207eddc0659986e0efa4fd10bbf5247f8fe62283d7c0d2e0b9bb51d36588e623a0688372aeb9bb9e95cff8c260b92651f575a1f9d9cf687308c60082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7c17eb6d763f7e160833cde85bc3ac206360683d794eff1c2474ea7813e6329b74a59c7531a2e88a1b0380571dc75f83053d432fbf2e27885315634f78ebfa24"} 03:34:10 INFO - Running post-run listener: copy_logs_to_upload_dir 03:34:10 INFO - Copying logs to upload dir... 03:34:10 INFO - mkdir: /builds/slave/test/build/upload/logs 03:34:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.776792 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2016-07-14 03:34:10.543309) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 03:34:10.546408) ========= 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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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/Autoland/sha512/f1bffbd982b3165813b837dace39eb6c0f4a6d7cdecd9572b3811fa3781ae7569148d91c4bc87e4331dec0524577d7014bc6452994bbe6e812393ae86f165eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a14e54ba207eddc0659986e0efa4fd10bbf5247f8fe62283d7c0d2e0b9bb51d36588e623a0688372aeb9bb9e95cff8c260b92651f575a1f9d9cf687308c60082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7c17eb6d763f7e160833cde85bc3ac206360683d794eff1c2474ea7813e6329b74a59c7531a2e88a1b0380571dc75f83053d432fbf2e27885315634f78ebfa24"} build_url:https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011055 build_url: 'https://queue.taskcluster.net/v1/task/I0QHab27RJyxOdVABR3DKw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1bffbd982b3165813b837dace39eb6c0f4a6d7cdecd9572b3811fa3781ae7569148d91c4bc87e4331dec0524577d7014bc6452994bbe6e812393ae86f165eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a14e54ba207eddc0659986e0efa4fd10bbf5247f8fe62283d7c0d2e0b9bb51d36588e623a0688372aeb9bb9e95cff8c260b92651f575a1f9d9cf687308c60082", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7c17eb6d763f7e160833cde85bc3ac206360683d794eff1c2474ea7813e6329b74a59c7531a2e88a1b0380571dc75f83053d432fbf2e27885315634f78ebfa24"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 03:34:10.578234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:34:10.578533) ========= 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.Ib6hBEOxv3/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.dtGkqquW8c/Listeners TMPDIR=/var/folders/9v/3t33my4n45z9l7y7__3lqm9r00000w/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.005296 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:34:10.627590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 03:34:10.627920) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 03:34:10.628209) ========= ========= Total master_lag: 0.62 =========