builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0139 starttime: 1467773102.55 results: success (0) buildid: 20160705180326 builduid: 729517e39bbb423da53326447d6d5020 revision: 78d2fb74e22f7d4858c88173071a5b6988c07389 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:02.546600) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:02.547054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:02.547331) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:02.630133) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:02.630396) ========= 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.Dp3W56IoYz/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.rRx33bI5NC/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-05 19:45:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 83.3M=0s 2016-07-05 19:45:03 (83.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.599994 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:03.255485) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:03.255809) ========= 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.Dp3W56IoYz/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.rRx33bI5NC/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.031041 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:03.312760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 19:45:03.313108) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 78d2fb74e22f7d4858c88173071a5b6988c07389 --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 78d2fb74e22f7d4858c88173071a5b6988c07389 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dp3W56IoYz/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.rRx33bI5NC/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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-05 19:45:03,386 truncating revision to first 12 chars 2016-07-05 19:45:03,386 Setting DEBUG logging. 2016-07-05 19:45:03,386 attempt 1/10 2016-07-05 19:45:03,386 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/78d2fb74e22f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 19:45:04,483 unpacking tar archive at: autoland-78d2fb74e22f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.352353 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-05 19:45:04.687435) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:04.687755) ========= script_repo_revision: 78d2fb74e22f7d4858c88173071a5b6988c07389 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:04.688156) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:04.688529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 19:45:04.711313) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-07-05 19:45:04.711677) ========= /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.Dp3W56IoYz/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.rRx33bI5NC/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:45:04 INFO - MultiFileLogger online at 20160705 19:45:04 in /builds/slave/test 19:45:04 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 19:45:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:45:04 INFO - {'append_to_log': False, 19:45:04 INFO - 'base_work_dir': '/builds/slave/test', 19:45:04 INFO - 'blob_upload_branch': 'Autoland', 19:45:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:45:04 INFO - 'branch': 'Autoland', 19:45:04 INFO - 'buildbot_json_path': 'buildprops.json', 19:45:04 INFO - 'config_files': ('talos/mac_config.py',), 19:45:04 INFO - 'default_actions': ('clobber', 19:45:04 INFO - 'read-buildbot-config', 19:45:04 INFO - 'download-and-extract', 19:45:04 INFO - 'populate-webroot', 19:45:04 INFO - 'create-virtualenv', 19:45:04 INFO - 'install', 19:45:04 INFO - 'run-tests'), 19:45:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:45:04 INFO - 'download_minidump_stackwalk': True, 19:45:04 INFO - 'download_symbols': 'ondemand', 19:45:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:45:04 INFO - 'tooltool.py': '/tools/tooltool.py', 19:45:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:45:04 INFO - '/tools/misc-python/virtualenv.py')}, 19:45:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:45:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:45:04 INFO - 'installer_path': 'installer.exe', 19:45:04 INFO - 'log_level': 'info', 19:45:04 INFO - 'log_name': 'talos', 19:45:04 INFO - 'log_to_console': True, 19:45:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:45:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:45:04 INFO - 'opt_config_files': (), 19:45:04 INFO - 'pip_index': False, 19:45:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:45:04 INFO - 'cmd': ('bash', 19:45:04 INFO - '-c', 19:45:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:45:04 INFO - 'enabled': True, 19:45:04 INFO - 'halt_on_failure': False, 19:45:04 INFO - 'name': 'check_screen_resolution'},), 19:45:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:45:04 INFO - 'cmd': ('bash', 19:45:04 INFO - '-c', 19:45:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:45:04 INFO - 'enabled': True, 19:45:04 INFO - 'halt_on_failure': False, 19:45:04 INFO - 'name': 'check_screen_resolution'},), 19:45:04 INFO - 'run_cmd_checks_enabled': True, 19:45:04 INFO - 'sps_profile': False, 19:45:04 INFO - 'sps_profile_interval': 0, 19:45:04 INFO - 'suite': 'dromaeojs-e10s', 19:45:04 INFO - 'system_bits': '32', 19:45:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:45:04 INFO - 'title': 't-yosemite-r7-0139', 19:45:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:45:04 INFO - 'use_talos_json': True, 19:45:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:45:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:45:04 INFO - 'work_dir': 'build'} 19:45:04 INFO - ##### 19:45:04 INFO - ##### Running clobber step. 19:45:04 INFO - ##### 19:45:04 INFO - Running pre-action listener: _resource_record_pre_action 19:45:04 INFO - Running main action method: clobber 19:45:04 INFO - rmtree: /builds/slave/test/build 19:45:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:45:06 INFO - Running post-action listener: _resource_record_post_action 19:45:06 INFO - ##### 19:45:06 INFO - ##### Finished clobber step (success) 19:45:06 INFO - ##### 19:45:06 INFO - ##### 19:45:06 INFO - ##### Running read-buildbot-config step. 19:45:06 INFO - ##### 19:45:06 INFO - Running pre-action listener: _resource_record_pre_action 19:45:06 INFO - Running main action method: read_buildbot_config 19:45:06 INFO - Using buildbot properties: 19:45:06 INFO - { 19:45:06 INFO - "project": "", 19:45:06 INFO - "product": "firefox", 19:45:06 INFO - "script_repo_revision": "production", 19:45:06 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 19:45:06 INFO - "repository": "", 19:45:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 19:45:06 INFO - "buildid": "20160705180326", 19:45:06 INFO - "pgo_build": "False", 19:45:06 INFO - "basedir": "/builds/slave/test", 19:45:06 INFO - "buildnumber": 25, 19:45:06 INFO - "slavename": "t-yosemite-r7-0139", 19:45:06 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:45:06 INFO - "platform": "yosemite_r7", 19:45:06 INFO - "scheduler": "tests-autoland-macosx64-talos", 19:45:06 INFO - "branch": "autoland", 19:45:06 INFO - "repo_path": "integration/autoland", 19:45:06 INFO - "revision": "78d2fb74e22f7d4858c88173071a5b6988c07389", 19:45:06 INFO - "stage_platform": "macosx64", 19:45:06 INFO - "builduid": "729517e39bbb423da53326447d6d5020", 19:45:06 INFO - "slavebuilddir": "test" 19:45:06 INFO - } 19:45:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 19:45:06 INFO - Running post-action listener: _resource_record_post_action 19:45:06 INFO - ##### 19:45:06 INFO - ##### Finished read-buildbot-config step (success) 19:45:06 INFO - ##### 19:45:06 INFO - ##### 19:45:06 INFO - ##### Running download-and-extract step. 19:45:06 INFO - ##### 19:45:06 INFO - Running pre-action listener: _resource_record_pre_action 19:45:06 INFO - Running main action method: download_and_extract 19:45:06 INFO - mkdir: /builds/slave/test/build/tests 19:45:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:45:06 INFO - https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 19:45:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:45:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 19:45:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:45:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:45:37 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 19:45:37 INFO - retry: attempt #1 caught exception: timed out 19:45:37 INFO - retry: Failed, sleeping 30 seconds before retrying 19:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 19:46:08 INFO - Downloaded 1199 bytes. 19:46:08 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 19:46:08 INFO - Using the following test package requirements: 19:46:08 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:46:08 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 19:46:08 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 19:46:08 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'jsshell-mac.zip'], 19:46:08 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 19:46:08 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 19:46:08 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 19:46:08 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 19:46:08 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 19:46:08 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 19:46:08 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 19:46:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:46:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:08 INFO - https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:46:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:46:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:46:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:10 INFO - Downloaded 18804160 bytes. 19:46:10 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'] 19:46:10 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 19:46:14 INFO - Return code: 0 19:46:14 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 19:46:14 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')]} 19:46:14 INFO - https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:46:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:46:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 19:46:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:15 INFO - Downloaded 18804160 bytes. 19:46: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'] 19:46: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 19:46:19 INFO - Return code: 0 19:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:19 INFO - https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:46:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:46:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 19:46:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:20 INFO - Downloaded 14403333 bytes. 19:46: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'] 19:46: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 19:46:20 INFO - Return code: 0 19:46: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')]} 19:46:20 INFO - https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:46:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:46:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:46:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 19:46:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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 19:46:24 INFO - Downloaded 112529246 bytes. 19:46:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:46:24 INFO - mkdir: /builds/slave/test/properties 19:46:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:46:24 INFO - Writing to file /builds/slave/test/properties/build_url 19:46:24 INFO - Contents: 19:46:24 INFO - build_url:https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 19:46:25 INFO - Running post-action listener: _resource_record_post_action 19:46:25 INFO - Running post-action listener: set_extra_try_arguments 19:46:25 INFO - ##### 19:46:25 INFO - ##### Finished download-and-extract step (success) 19:46:25 INFO - ##### 19:46:25 INFO - ##### 19:46:25 INFO - ##### Running populate-webroot step. 19:46:25 INFO - ##### 19:46:25 INFO - Running pre-action listener: _resource_record_pre_action 19:46:25 INFO - Running main action method: populate_webroot 19:46:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:46:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:46:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:46:25 INFO - '--tppagecycles', 19:46:25 INFO - '7'], 19:46:25 INFO - 'tests': ['tsvgm']}}, 19:46:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:46:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:46:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:46:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:46:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:46:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['damp', 'tps']}, 19:46:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'tests': ['damp', 'tps']}, 19:46:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['dromaeo_dom']}, 19:46:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:46:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['basic_compositor_video']}, 19:46:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:46:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['a11yr', 19:46:25 INFO - 'ts_paint', 19:46:25 INFO - 'tpaint', 19:46:25 INFO - 'sessionrestore', 19:46:25 INFO - 'sessionrestore_no_auto_restore', 19:46:25 INFO - 'tabpaint']}, 19:46:25 INFO - 'other-e10s': {'tests': ['a11yr', 19:46:25 INFO - 'ts_paint', 19:46:25 INFO - 'tpaint', 19:46:25 INFO - 'sessionrestore', 19:46:25 INFO - 'sessionrestore_no_auto_restore', 19:46:25 INFO - 'tabpaint']}, 19:46:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:46:25 INFO - 'ts_paint', 19:46:25 INFO - 'tpaint', 19:46:25 INFO - 'sessionrestore', 19:46:25 INFO - 'sessionrestore_no_auto_restore', 19:46:25 INFO - 'tabpaint']}, 19:46:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:46:25 INFO - 'ts_paint', 19:46:25 INFO - 'tpaint', 19:46:25 INFO - 'sessionrestore', 19:46:25 INFO - 'sessionrestore_no_auto_restore', 19:46:25 INFO - 'tabpaint']}, 19:46:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['a11yr', 19:46:25 INFO - 'ts_paint', 19:46:25 INFO - 'tpaint', 19:46:25 INFO - 'sessionrestore', 19:46:25 INFO - 'sessionrestore_no_auto_restore', 19:46:25 INFO - 'tabpaint']}, 19:46:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['a11yr', 19:46:25 INFO - 'ts_paint', 19:46:25 INFO - 'tpaint', 19:46:25 INFO - 'sessionrestore', 19:46:25 INFO - 'sessionrestore_no_auto_restore', 19:46:25 INFO - 'tabpaint']}, 19:46:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['tsvgx', 19:46:25 INFO - 'tsvgr_opacity', 19:46:25 INFO - 'tart', 19:46:25 INFO - 'tscrollx', 19:46:25 INFO - 'cart']}, 19:46:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:46:25 INFO - 'tsvgr_opacity', 19:46:25 INFO - 'tart', 19:46:25 INFO - 'tscrollx', 19:46:25 INFO - 'cart']}, 19:46:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'talos_options': ['--disable-e10s'], 19:46:25 INFO - 'tests': ['tp5o']}, 19:46:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'tests': ['tp5o']}, 19:46:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'talos_options': ['--disable-e10s', 19:46:25 INFO - '--xperf_path', 19:46:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:25 INFO - 'tests': ['tp5n']}, 19:46:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:46:25 INFO - 'talos_options': ['--xperf_path', 19:46:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:46:25 INFO - 'tests': ['tp5n']}}, 19:46:25 INFO - 'talos.zip': {'path': '', 19:46:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:46:25 INFO - Running post-action listener: _resource_record_post_action 19:46:25 INFO - ##### 19:46:25 INFO - ##### Finished populate-webroot step (success) 19:46:25 INFO - ##### 19:46:25 INFO - ##### 19:46:25 INFO - ##### Running create-virtualenv step. 19:46:25 INFO - ##### 19:46:25 INFO - Running pre-action listener: _resource_record_pre_action 19:46:25 INFO - Running main action method: create_virtualenv 19:46:25 INFO - Creating virtualenv /builds/slave/test/build/venv 19:46:25 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 19:46:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:46:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:46:25 INFO - Using real prefix '/tools/python27' 19:46:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:46:26 INFO - Installing distribute.............................................................................................................................................................................................done. 19:46:29 INFO - Installing pip.................done. 19:46:29 INFO - Return code: 0 19:46:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:29 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:29 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 19:46:29 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 19:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:29 INFO - 'HOME': '/Users/cltbld', 19:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:29 INFO - 'LOGNAME': 'cltbld', 19:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:29 INFO - 'MOZ_NO_REMOTE': '1', 19:46:29 INFO - 'NO_EM_RESTART': '1', 19:46:29 INFO - 'PAGER': '/bin/cat', 19:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:29 INFO - 'PWD': '/builds/slave/test', 19:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:29 INFO - 'SHELL': '/bin/bash', 19:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:29 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:29 INFO - 'USER': 'cltbld', 19:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:29 INFO - 'XPC_FLAGS': '0x0', 19:46:29 INFO - 'XPC_SERVICE_NAME': '0', 19:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:29 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 19:46:29 INFO - Cleaning up... 19:46:29 INFO - Return code: 0 19:46:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:29 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:29 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 19:46:29 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 19:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:29 INFO - 'HOME': '/Users/cltbld', 19:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:29 INFO - 'LOGNAME': 'cltbld', 19:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:29 INFO - 'MOZ_NO_REMOTE': '1', 19:46:29 INFO - 'NO_EM_RESTART': '1', 19:46:29 INFO - 'PAGER': '/bin/cat', 19:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:29 INFO - 'PWD': '/builds/slave/test', 19:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:29 INFO - 'SHELL': '/bin/bash', 19:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:29 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:29 INFO - 'USER': 'cltbld', 19:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:29 INFO - 'XPC_FLAGS': '0x0', 19:46:29 INFO - 'XPC_SERVICE_NAME': '0', 19:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:29 INFO - Downloading/unpacking psutil>=3.1.1 19:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:46:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:32 INFO - Installing collected packages: psutil 19:46:32 INFO - Running setup.py install for psutil 19:46:32 INFO - building 'psutil._psutil_osx' extension 19:46:32 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 19:46:33 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 19:46:33 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 19:46:33 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 19:46:33 INFO - building 'psutil._psutil_posix' extension 19:46:33 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 19:46:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:46:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:46:33 INFO - ^ 19:46:33 INFO - 1 warning generated. 19:46:33 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 19:46:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:46:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:46:33 INFO - Successfully installed psutil 19:46:33 INFO - Cleaning up... 19:46:33 INFO - Return code: 0 19:46:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:33 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:33 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 19:46:33 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 19:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:33 INFO - 'HOME': '/Users/cltbld', 19:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:33 INFO - 'LOGNAME': 'cltbld', 19:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:33 INFO - 'MOZ_NO_REMOTE': '1', 19:46:33 INFO - 'NO_EM_RESTART': '1', 19:46:33 INFO - 'PAGER': '/bin/cat', 19:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:33 INFO - 'PWD': '/builds/slave/test', 19:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:33 INFO - 'SHELL': '/bin/bash', 19:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:33 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:33 INFO - 'USER': 'cltbld', 19:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:33 INFO - 'XPC_FLAGS': '0x0', 19:46:33 INFO - 'XPC_SERVICE_NAME': '0', 19:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:46:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:46:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:46:36 INFO - Installing collected packages: mozsystemmonitor 19:46:36 INFO - Running setup.py install for mozsystemmonitor 19:46:36 INFO - Successfully installed mozsystemmonitor 19:46:36 INFO - Cleaning up... 19:46:36 INFO - Return code: 0 19:46:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:46:36 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')]} 19:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:36 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')]} 19:46:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:36 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:36 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 19:46:36 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 19:46:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:36 INFO - 'HOME': '/Users/cltbld', 19:46:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:36 INFO - 'LOGNAME': 'cltbld', 19:46:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:36 INFO - 'MOZ_NO_REMOTE': '1', 19:46:36 INFO - 'NO_EM_RESTART': '1', 19:46:36 INFO - 'PAGER': '/bin/cat', 19:46:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:36 INFO - 'PWD': '/builds/slave/test', 19:46:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:36 INFO - 'SHELL': '/bin/bash', 19:46:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:36 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:36 INFO - 'USER': 'cltbld', 19:46:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:36 INFO - 'XPC_FLAGS': '0x0', 19:46:36 INFO - 'XPC_SERVICE_NAME': '0', 19:46:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:37 INFO - Downloading/unpacking jsonschema==2.5.1 19:46:37 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 19:46:37 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 19:46:37 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 19:46:37 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 19:46:37 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 19:46:37 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 19:46:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:46:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:39 INFO - Downloading functools32-3.2.3-2.tar.gz 19:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:46:39 INFO - warning: no files found matching '*.txt' 19:46:39 INFO - no previously-included directories found matching 'build' 19:46:39 INFO - no previously-included directories found matching 'dist' 19:46:39 INFO - no previously-included directories found matching '.git*' 19:46:39 INFO - Installing collected packages: jsonschema, functools32 19:46:39 INFO - Running setup.py install for functools32 19:46:40 INFO - warning: no files found matching '*.txt' 19:46:40 INFO - no previously-included directories found matching 'build' 19:46:40 INFO - no previously-included directories found matching 'dist' 19:46:40 INFO - no previously-included directories found matching '.git*' 19:46:40 INFO - Successfully installed jsonschema functools32 19:46:40 INFO - Cleaning up... 19:46:40 INFO - Return code: 0 19:46:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:46:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:40 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:40 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 19:46:40 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 19:46:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:40 INFO - 'HOME': '/Users/cltbld', 19:46:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:40 INFO - 'LOGNAME': 'cltbld', 19:46:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:40 INFO - 'MOZ_NO_REMOTE': '1', 19:46:40 INFO - 'NO_EM_RESTART': '1', 19:46:40 INFO - 'PAGER': '/bin/cat', 19:46:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:40 INFO - 'PWD': '/builds/slave/test', 19:46:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:40 INFO - 'SHELL': '/bin/bash', 19:46:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:40 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:40 INFO - 'USER': 'cltbld', 19:46:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:40 INFO - 'XPC_FLAGS': '0x0', 19:46:40 INFO - 'XPC_SERVICE_NAME': '0', 19:46:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:40 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:42 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:46:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:44 INFO - Downloading docopt-0.6.1.tar.gz 19:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:44 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:44 INFO - Running setup.py install for blobuploader 19:46:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:46:44 INFO - Running setup.py install for requests 19:46:44 INFO - Running setup.py install for docopt 19:46:44 INFO - Successfully installed blobuploader requests docopt 19:46:44 INFO - Cleaning up... 19:46:45 INFO - Return code: 0 19:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 19:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:45 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:45 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 19:46:45 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 19:46:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:45 INFO - 'HOME': '/Users/cltbld', 19:46:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:45 INFO - 'LOGNAME': 'cltbld', 19:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:45 INFO - 'MOZ_NO_REMOTE': '1', 19:46:45 INFO - 'NO_EM_RESTART': '1', 19:46:45 INFO - 'PAGER': '/bin/cat', 19:46:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:45 INFO - 'PWD': '/builds/slave/test', 19:46:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:45 INFO - 'SHELL': '/bin/bash', 19:46:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:45 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:45 INFO - 'USER': 'cltbld', 19:46:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:45 INFO - 'XPC_FLAGS': '0x0', 19:46:45 INFO - 'XPC_SERVICE_NAME': '0', 19:46:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-JoCN7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-M9fYNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-LrPu3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-1EnSvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-pbZ9Ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-KKGGMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-aQfKUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:45 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-AfMRgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mrg6s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-C1IM0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-5iSCUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9gCj2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-bleFA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-fIXQv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-2inlAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-iwJ4wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:46 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-UL0of4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:47 INFO - Running setup.py install for manifestparser 19:46:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:46:47 INFO - Running setup.py install for mozcrash 19:46:47 INFO - Running setup.py install for mozdebug 19:46:47 INFO - Running setup.py install for mozdevice 19:46:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:46:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:46:47 INFO - Running setup.py install for mozfile 19:46:47 INFO - Running setup.py install for mozhttpd 19:46:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:46:47 INFO - Running setup.py install for mozinfo 19:46:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Running setup.py install for mozInstall 19:46:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Running setup.py install for mozleak 19:46:48 INFO - Running setup.py install for mozlog 19:46:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Running setup.py install for moznetwork 19:46:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Running setup.py install for mozprocess 19:46:48 INFO - Running setup.py install for mozprofile 19:46:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:46:48 INFO - Running setup.py install for mozrunner 19:46:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:46:49 INFO - Running setup.py install for mozscreenshot 19:46:49 INFO - Running setup.py install for moztest 19:46:49 INFO - Running setup.py install for mozversion 19:46:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:46:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:49 INFO - Cleaning up... 19:46:49 INFO - Return code: 0 19:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:49 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')]} 19:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:49 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')]} 19:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:49 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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46:49 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 19:46:49 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 19:46:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:49 INFO - 'HOME': '/Users/cltbld', 19:46:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:49 INFO - 'LOGNAME': 'cltbld', 19:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:49 INFO - 'MOZ_NO_REMOTE': '1', 19:46:49 INFO - 'NO_EM_RESTART': '1', 19:46:49 INFO - 'PAGER': '/bin/cat', 19:46:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:49 INFO - 'PWD': '/builds/slave/test', 19:46:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:49 INFO - 'SHELL': '/bin/bash', 19:46:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:49 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:49 INFO - 'USER': 'cltbld', 19:46:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:49 INFO - 'XPC_FLAGS': '0x0', 19:46:49 INFO - 'XPC_SERVICE_NAME': '0', 19:46:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-tvANk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46: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)) 19:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:49 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-IzuHtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:50 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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ivXdYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:50 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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-AKJtio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:50 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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-3VWffO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:50 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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-CHoBLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:50 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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Y0w2et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:50 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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-GBMifp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46: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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-wd7UA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46: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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-ee6bvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46: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)) 19:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:50 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-Dvr8lu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:51 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)) 19:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-QQCDui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-BYihkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:51 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)) 19:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-9hK1IW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-mW2Skk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:51 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)) 19:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-yYSIQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:51 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)) 19:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:51 INFO - Running setup.py (path:/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/pip-UVwDJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46: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 19:46:54 INFO - Downloading blessings-1.6.tar.gz 19:46:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:46:54 INFO - Installing collected packages: blessings 19:46:54 INFO - Running setup.py install for blessings 19:46:54 INFO - Successfully installed blessings 19:46:54 INFO - Cleaning up... 19:46:54 INFO - Return code: 0 19:46:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:54 INFO - Reading from file tmpfile_stdout 19:46:54 INFO - Current package versions: 19:46:54 INFO - blessings == 1.6 19:46:54 INFO - blobuploader == 1.2.4 19:46:54 INFO - docopt == 0.6.1 19:46:54 INFO - functools32 == 3.2.3-2 19:46:54 INFO - jsonschema == 2.5.1 19:46:54 INFO - manifestparser == 1.1 19:46:54 INFO - mozInstall == 1.12 19:46:54 INFO - mozcrash == 0.17 19:46:54 INFO - mozdebug == 0.1 19:46:54 INFO - mozdevice == 0.48 19:46:54 INFO - mozfile == 1.2 19:46:54 INFO - mozhttpd == 0.7 19:46:54 INFO - mozinfo == 0.9 19:46:54 INFO - mozleak == 0.1 19:46:54 INFO - mozlog == 3.2 19:46:54 INFO - moznetwork == 0.27 19:46:54 INFO - mozprocess == 0.22 19:46:54 INFO - mozprofile == 0.28 19:46:54 INFO - mozrunner == 6.11 19:46:54 INFO - mozscreenshot == 0.1 19:46:54 INFO - mozsystemmonitor == 0.3 19:46:54 INFO - moztest == 0.7 19:46:54 INFO - mozversion == 1.4 19:46:54 INFO - psutil == 3.1.1 19:46:54 INFO - requests == 1.2.3 19:46:54 INFO - wsgiref == 0.1.2 19:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46: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 19:46: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 19:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:54 INFO - 'HOME': '/Users/cltbld', 19:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:54 INFO - 'LOGNAME': 'cltbld', 19:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:54 INFO - 'MOZ_NO_REMOTE': '1', 19:46:54 INFO - 'NO_EM_RESTART': '1', 19:46:54 INFO - 'PAGER': '/bin/cat', 19:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:54 INFO - 'PWD': '/builds/slave/test', 19:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:54 INFO - 'SHELL': '/bin/bash', 19:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:54 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:54 INFO - 'USER': 'cltbld', 19:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:54 INFO - 'XPC_FLAGS': '0x0', 19:46:54 INFO - 'XPC_SERVICE_NAME': '0', 19:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46: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)) 19:46:54 INFO - Cleaning up... 19:46:54 INFO - Return code: 0 19:46:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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 0x106e5fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ef4618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd999573dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, '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.Dp3W56IoYz/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.rRx33bI5NC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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 19:46: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 19:46: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 19:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:46:54 INFO - 'HOME': '/Users/cltbld', 19:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:46:54 INFO - 'LOGNAME': 'cltbld', 19:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:54 INFO - 'MOZ_NO_REMOTE': '1', 19:46:54 INFO - 'NO_EM_RESTART': '1', 19:46:54 INFO - 'PAGER': '/bin/cat', 19:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:54 INFO - 'PWD': '/builds/slave/test', 19:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:46:54 INFO - 'SHELL': '/bin/bash', 19:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:46:55 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:46:55 INFO - 'USER': 'cltbld', 19:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:55 INFO - 'XPC_FLAGS': '0x0', 19:46:55 INFO - 'XPC_SERVICE_NAME': '0', 19:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:46:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:46:55 INFO - Cleaning up... 19:46:55 INFO - Return code: 0 19:46:55 INFO - Running post-action listener: _resource_record_post_action 19:46:55 INFO - Running post-action listener: _start_resource_monitoring 19:46:55 INFO - Starting resource monitoring. 19:46:55 INFO - ##### 19:46:55 INFO - ##### Finished create-virtualenv step (success) 19:46:55 INFO - ##### 19:46:55 INFO - ##### 19:46:55 INFO - ##### Running install step. 19:46:55 INFO - ##### 19:46:55 INFO - Running pre-action listener: _resource_record_pre_action 19:46:55 INFO - Running main action method: install 19:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:55 INFO - Reading from file tmpfile_stdout 19:46:55 INFO - Detecting whether we're running mozinstall >=1.0... 19:46:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:46:55 INFO - Reading from file tmpfile_stdout 19:46:55 INFO - Output received: 19:46:55 INFO - Usage: mozinstall [options] installer 19:46:55 INFO - Options: 19:46:55 INFO - -h, --help show this help message and exit 19:46:55 INFO - -d DEST, --destination=DEST 19:46:55 INFO - Directory to install application into. [default: 19:46:55 INFO - "/builds/slave/test"] 19:46:55 INFO - --app=APP Application being installed. [default: firefox] 19:46:55 INFO - mkdir: /builds/slave/test/build/application 19:46: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'] 19:46: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 19:47:30 INFO - Reading from file tmpfile_stdout 19:47:30 INFO - Output received: 19:47:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:47:30 INFO - Running post-action listener: _resource_record_post_action 19:47:30 INFO - ##### 19:47:30 INFO - ##### Finished install step (success) 19:47:30 INFO - ##### 19:47:30 INFO - ##### 19:47:30 INFO - ##### Running run-tests step. 19:47:30 INFO - ##### 19:47:30 INFO - Running pre-action listener: _resource_record_pre_action 19:47:30 INFO - Running main action method: run_tests 19:47:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:47:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:47:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:47:30 INFO - 2016-07-05 19:47:30.491 screenresolution[1646:8277] starting screenresolution argv=screenresolution get 19:47:30 INFO - 2016-07-05 19:47:30.494 screenresolution[1646:8277] Display 0: 1600x1200x32@60 19:47:30 INFO - 2016-07-05 19:47:30.500 screenresolution[1647:8279] starting screenresolution argv=screenresolution list 19:47:30 INFO - Available Modes on Display 0 19:47:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:47:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:47:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:47:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:47:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:47:30 INFO - Intel Iris: 19:47:30 INFO - Chipset Model: Intel Iris 19:47:30 INFO - Type: GPU 19:47:30 INFO - Bus: Built-In 19:47:30 INFO - VRAM (Dynamic, Max): 1536 MB 19:47:30 INFO - Vendor: Intel (0x8086) 19:47:30 INFO - Device ID: 0x0a2e 19:47:30 INFO - Revision ID: 0x0009 19:47:30 INFO - Displays: 19:47:30 INFO - Display: 19:47:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:47:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:47:30 INFO - Display Serial Number: 1600x1200 60 19:47:30 INFO - Main Display: Yes 19:47:30 INFO - Mirror: Off 19:47:30 INFO - Online: Yes 19:47:30 INFO - Rotation: Supported 19:47:30 INFO - Return code: 0 19:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:47:30 INFO - Python 2.7.3 19:47:30 INFO - Return code: 0 19:47:30 INFO - grabbing minidump binary from tooltool 19:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:30 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 0x106dc3d30>, '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 0x106b28db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dbbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:47:30 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 19:47:30 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 19:47:30 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 19:47:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:47:30 INFO - Return code: 0 19:47:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:47:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:47:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:47:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:47:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:47:30 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/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 19:47:30 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/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0139 --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 19:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dp3W56IoYz/Render', 19:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:47:30 INFO - 'HOME': '/Users/cltbld', 19:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:47:30 INFO - 'LOGNAME': 'cltbld', 19:47:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:47:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:30 INFO - 'MOZ_NO_REMOTE': '1', 19:47:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:47:30 INFO - 'NO_EM_RESTART': '1', 19:47:30 INFO - 'PAGER': '/bin/cat', 19:47:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:30 INFO - 'PWD': '/builds/slave/test', 19:47:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:47:30 INFO - 'SHELL': '/bin/bash', 19:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rRx33bI5NC/Listeners', 19:47:30 INFO - 'TMPDIR': '/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/', 19:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:47:30 INFO - 'USER': 'cltbld', 19:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:30 INFO - 'XPC_FLAGS': '0x0', 19:47:30 INFO - 'XPC_SERVICE_NAME': '0', 19:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:47:30 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/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0139', '--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 19:47:31 INFO - mozversion application_buildid: 20160705180326 19:47:31 INFO - mozversion application_changeset: 78d2fb74e22f7d4858c88173071a5b6988c07389 19:47:31 INFO - mozversion application_display_name: Nightly 19:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:47:31 INFO - mozversion application_name: Firefox 19:47:31 INFO - mozversion application_remotingname: firefox 19:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 19:47:31 INFO - mozversion application_vendor: Mozilla 19:47:31 INFO - mozversion application_version: 50.0a1 19:47:31 INFO - mozversion platform_buildid: 20160705180326 19:47:31 INFO - mozversion platform_changeset: 78d2fb74e22f7d4858c88173071a5b6988c07389 19:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 19:47:31 INFO - mozversion platform_version: 50.0a1 19:47:31 INFO - using testdate: 1467773251 19:47:31 INFO - actual date: 1467773251 19:47:31 INFO - starting webserver on 'localhost:49275' 19:47:31 INFO - SUITE-START | Running 2 tests 19:47:31 INFO - TEST-START | dromaeo_css 19:47:31 INFO - operating with platform_type : mac_ 19:47:31 INFO - Initialising browser for dromaeo_css test... 19:47:31 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpykoiSQ/profile http://localhost:49275/getInfo.html) 19:47:34 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 19:47:34 INFO - PROCESS | 1657 | colorDepth:24 19:47:34 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 19:47:34 INFO - PROCESS | 1657 | __metrics 19:47:34 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 19:47:34 INFO - TEST-INFO | 1657: exit 0 19:47:34 INFO - Browser initialized. 19:47:34 INFO - Running cycle 1/1 for dromaeo_css test... 19:47:34 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmpykoiSQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:46 INFO - PROCESS | 1661 | RSS: Main: 255877120 19:47:46 INFO - PROCESS | 1661 | 19:48:36 INFO - PROCESS | 1661 | 1467773316466 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] 19:50:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 19:50:49 INFO - PROCESS | 1661 | RSS: Main: 270446592 19:50:49 INFO - PROCESS | 1661 | 19:53:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 19:53:52 INFO - PROCESS | 1661 | RSS: Main: 278773760 19:53:52 INFO - PROCESS | 1661 | 19:56:54 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 19:56:55 INFO - PROCESS | 1661 | RSS: Main: 283160576 19:56:55 INFO - PROCESS | 1661 | 19:59:56 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 19:59:57 INFO - PROCESS | 1661 | RSS: Main: 282505216 19:59:57 INFO - PROCESS | 1661 | 20:03:00 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 20:03:00 INFO - PROCESS | 1661 | RSS: Main: 285683712 20:03:00 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 20:06:03 INFO - PROCESS | 1661 | RSS: Main: 285765632 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | __start_tp_report 20:06:03 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 20:06:03 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 20:06:03 INFO - PROCESS | 1661 | |i|pagename|runs| 20:06:03 INFO - PROCESS | 1661 | |0;dojo.html;2948.970510294899;3392.694657480826;3431.8798842040533;3436.7766095203815;3459;5826.9999999999945;5832.387599302076;5850.180974663545;5899.616524925877;5910.970445147774;5699.943000569993;5886.058230683092;5925.785214031124;5971.954907891112;6034.5172386209;5291.206319052135;5330.920036199441;5343.946560534394;5365.865853353678;5386.353637563498;5308.309919710432;5441.29263195784;5455.263539422187;5498.0653288940775;5547.583931205176;5217.191335343028;5258.079836028718;5352.973235133838;5385.2999110115825;5421.024215641183;5339.225812257239;5345.732713364317;5347.973260133675;5352.652077614943;5372.2210279509645;5276.709780962045;5315.388730295988;5351.331083614548;5356.95539369823;5365.248865158881;5170.922436163461;5349.277847490578;5812.041013232812;5875.559333049996;5880.294364676223;6130.111133885606;6171.321154672983;6192.504599632019;6202.441780239755;6206.596571222856;6201.45009031963;6256.499480041586;6266.279377871558;6266.934621114421;6279.434850863398;5830.650160990354;5946.464818166386;6030.125631783455;6035.124906888476;6040.335563088057;6369;6422.775202867971;6426.678666066771;6433.324500927429;6439.774607888701;6094.169091873587;6173.32093469718;6189.84525386869;6198.442140207403;6198.783042593487;6129.23653806838;6160.260768707783;6174.351693072253;6219.253689557192;6252.124702541648;6113.113598528189;6143.354947730513;6161.229846269216;6164.352742962014;6195.876082478325;6112.74665817949;6187.319394866561;6187.535934804908;6200.844978875564;6206.100115483229;4936.925946110811;4985.4017517897355;5003.5997120230295;5007.574356179693;5018.121828679967;4398.824047038082;4415.823367065345;4441.911161776811;4455.910881782346;4496.9325460118125;5273.630845840831;5696.772129114789;5804.506616937608;5906.173135760997;5961.076033214772;6208.099825525273;6254.061890716338;6266.561340706198;6278.529110316745;6280.2777680566405;5994.220751302303;6004.189434426296;6026.578139530191;6046.881326954527;6054.364291749391;5369.275147855068;5436.3476382834315;5458.727063646802;5468.097763868917;5531.751071201806;6302.905456418157;6449.613023218434;6470.935290647033;6488.772892948724;6489.902651460137;5402.837914862561;6213.440790328892;6236.968815155895;6269.247690277196;6341.397567231105;5755.568332375173;6137.772445510826;6241.625502469867;6311.400416960381;6356;6168.506519478341;6187.443130118311;6204.348543402878;6217.564770466205;6236.376362363727;5329.813456529003;6116.021436570128;6251.187345645219;6255.781047663492;6272.5922815016875;6144.354842741448;6154.661493617894;6159.5072394209255;6187.535934804818;6217.782377616762;5130.51260130287;5306.204069389622;6218.626882387071;6226;6251.218597675291;6054.66699331541;6082;6152.292486363946;6157.138000679998;6203.16257305258;6098.908516372347;6146.754129834757;6149.2620885494025;6170.753169873335;6250;6106.236720409949;6117.449429551361;6164.321924588381;6166.383361663977;6167.044108163242 20:06:03 INFO - PROCESS | 1661 | |1;ext.html;506.382213699287;509.93880734311887;526.3210458508524;557.707203718048;558.678759713165;38405.807970960144;40380;40914.97712557187;40916.56792012276;40922;36084.45873311896;38540.42189367155;40577.98555036118;41239;41239.793801031024;8736.956315218447;9073.228775554086;9536.188124256403;9616.567254473566;9640.71077867665;9632.662856800014;9689;9728.464934428604;9736.51317434129;9750.12248897599;9704.466254356008;9734.415935043884;9738.707838764813;9780.55987480565;9823.95088024559;9692.27307951903;9734.951325243364;9744.90255097447;9752.512374381324;9768.316217864753;9627.133557979745;9672.22622190223;9694.22446204309;9723.270754693427;9761.414315141043;39844.60155398438;40079.19841603152;40155.59844401548;40162.598374016474;40437.19125617471;3412.7611067225303;3503.1242189452637;3554.573451185848;3995.580464051262;4096.016955930585;26940.730592694017;31360.843195783877;31932.840335798406;32195.034148975566;32503;3224.5324427957817;3278.393497203025;3392.4911263310455;3408.1479630092476;3408.6932176104024;481998;485336;490401;491431;494785.52607237094;60979;61165;61185;61270.38729612736;61537.384626153165;62146;62411.37588624146;63321;63803.68098159479;63851.68074159599;13921.886249100047;14466.566003019927;15708.92145539265;16543.6691266174;16756.827022108337;12698.238105713686;13032;13110;13112.344382780822;13132.540361087316;15904.840951590568;16521.00873947543;16522.917385413235;16557.503274901774;16624.6675066498;3242.124626350872;6495.1556297681;6656.101426307387;6699.698513566901;6748;771.5293670860771;987.4618333008527;1007.8034783217349;1088.1458055426451;1102.4267380961855;30694;30713.539296910563;30889.69110308913;31149.377012459623;31327.37345253082;1077.106002018323;1128.470921900829;1173.12015988009;1176.3823992404057;1181.3207405741562;14420.783688244685;15166;15949.44176953801;16173.838261617468;16338.039435267843;533173.6730530813;624200;633452.8327358426;634025;635394;59629;60163;60315.69842150849;60427;60470.395296047354;1403.1791402029723;1411.4354258296764;1467.7651575748043;1468.155810409019;1471.1908450352264;26215.213543593723;29535;30646.08061758151;30665;31358.843205783825;51241;51510.48489515057;52218.738906305225;52380.73809630927;52723.736381317845;563927;566067;568230.3176968343;568432;568943;26995.38027718343;27090.864545677145;27212.183634490204;27392.726072739017;27461.86269068642;47869.28196076992;48180.5181948176;48696;49025.26462103;49086.509134909626;39303.80348098241;40699.79650101731;40717.796411017756;40730.59269407268;40909.590904090575;39775.40336894891;40110;40461.78614641565;41038.9740256496;41226.58773412347;38356.232875342896;38573.2285354297;39138.60861391349;39373.80313098531;39488.60511394849;31974;32165.356692865542;34672.82663586767;35008;35340.469892951114;24157;24243.666598337262;25813.418658134036;26673.799679014104;26709.465810684065 20:06:03 INFO - PROCESS | 1661 | |2;jquery.html;374.262702476122;377.3415390144197;385.8186652273432;390.4202259644426;394.52065740125744;18154.5461363466;19616.509587260327;20725.378238652826;21907;22033.559328813433;20917.686234706493;21424.03591838367;21758.78241217591;21815;21949;5521.309836270466;5916.0238560637445;6787.5588086774205;6797.28628494006;6901.654917254143;6695.196576410837;6789.558678685894;6790.490713196506;6803.285655006227;6829.180498340206;6036.788712395067;6313.905291420632;6726.159230096238;6742.730290788362;6743.224529179158;5702.714864256771;5792.594518383715;5898.469137777599;6415.518836087289;6688.86622267552;4870.245112007609;5725.685087320196;5815.389384114649;5816.185733997244;5842.591018628697;11376.374299413528;15512.844871551253;18828;22949.655755163687;24253;2173.673948907661;2174.9782502175094;2199.56008798241;2279.3959600705825;2898.565150527321;10096.29325947184;10175.287729858914;10195.592176312939;10214.642487512901;10291;1736.5311365931127;1842.9262829486804;1867.766529183852;1909.3699079303797;1946.8247857692734;66478;100111;110675.44662276718;116837.41581292124;130710;11410.600628977945;11416.828747568794;11577.6526704199;11612.825807612893;11780.646580602595;14497.782533262009;14541.927290363692;14562.708745825024;14585.197814120113;14592.63518412027;8499.74500764978;8651.95674021626;8676.522791246542;8713.564321783886;8726.476411415208;8628.482291062557;8690.174433428814;8690.956545217234;8708.911386076741;8784;3680.1719613086843;4408.955910440919;4477.507474177838;4569.13186494565;4595.035042641083;1778.9377371792184;1862.8729618580835;1940.427573865713;1942.3201879342116;1995.3714579907282;833.2084519706303;852.863541833316;945.976350591227;977.3940157102642;1053.8946105389552;20576;21805;22202.11191552352;22228.11087556512;22257.888710556344;907.7685190276569;917.6448436981323;933.6265493802533;941.9293552983554;981.9558119884622;11163.609273675382;11641.53433862653;11694.661067786306;11705.88294117065;11706.180567360203;546422;548639;553583;554232;601108;56269;74937;114762.42618786852;133556.3322183383;134463;995.6807230419723;1015.7663737340305;1031.8091153136543;1051.164324362134;1051.4374809477047;19526.8047319525;19784.604307913472;19849.40451786449;19991.60016799685;20055.29806456767;58543.53641158835;59151;59271.703641481516;60559;61369;71284.28715712776;80087;83784.16215837763;83788;86531.56734216289;6771.458283337222;7321.707131714885;7749.302562769378;7986.720464783704;8026.197380261927;11502.19484636101;12659.810102848649;13270.270135142273;13290.534831280858;13605.591832245049;10692.732681683021;11337.659870203906;11409.942950285527;11461.942690286494;11532.25040372373;11315.660530184108;11325.32048077118;11373.943130284295;11387.202895797545;11450.198486106226;11632.302061876315;11669.35818529989;11683.474243658886;11716.589919352782;11826.940865295963;8064.274215320649;8104.108548059591;8110.959445202736;8181.222783835526;8270.137221098204;8286.502809831429;10400.27198096126;11400.885991140314;11434.599789007345;11528.135389845627 20:06:03 INFO - PROCESS | 1661 | |3;mootools.html;1414.2716501001985;1566.5457017464933;1777.8399944005037;1898.743669604603;1920.5582715975324;7983.52098874068;8533.445326053803;8680.869786953193;9135.314851386147;9151.725448236546;8667.826643467128;8748.650053997833;8899.243564297043;8911.821763564725;8915.286777057836;2364.1252736487436;2375.893084811179;2392.0790495659207;2397.280815755275;2403.194929698553;2159.8380121490873;2292.403974966504;2307.284741730061;2338.614128668776;2364.290712786166;2346.9295921122393;2350.6239001759723;2365.899856566696;2379.7858192762646;2380.2978121454125;2329.592321343758;2343.4610039690883;2354.8940297686645;2356.069352605711;2364.4207169243473;2302.873341966191;2335.8131349492;2342.6603142544404;2348.894299756515;2356.081128359941;8901.376903616685;8915.28677705782;8950.776230594221;9035.593398297093;9045.321600879895;5302.2841916341185;5365.678059316415;5434.456554344534;5450.809221677222;5453.127499600045;3591.982040089809;3668.633136686337;3669.7981611011382;3744.7753134811996;3750.981245093757;1074.8602681651414;1088.9945550272278;1101.911847052234;1114.3648120571277;1115.7991561518922;9716.222702183879;11579;11752.177347585672;11762.235454695418;11780.410979451079;4629.6990695605355;4669.322948172564;4856.3201151838775;4865.9756701216265;4868.513148685103;9918.30571859963;10046.69859904204;10050;10071.34536255141;10073.899261007442;5374.4625537445945;5419.566434685215;5420.620556561003;5425.728713564306;5438.993786149575;4392.428984232093;4739.526047395302;4891.584215341664;4916.655834091579;4954.3063971044085;3405.370006548747;3989.4813674222746;4087.9795601021806;4093.242750091183;4135.91728165435;1300.408314217048;1300.7723648361498;1308.7644224039764;1311.0560396514495;1322.3388305847077;902.6434558349415;916.4592890194817;920.5075284722641;942.4863449420083;969.5491596407704;5717.399673034354;5831.387704290988;5885.852853678693;6050.606710563799;6093.29927058394;431.8704388683382;445.5321911992395;445.66797735687123;455.4602795687121;462.22115734986653;3860.285847118292;4007.979960100181;4053.0272734543496;4086.223617512663;4102.774347410921;10074.194064474825;10778.568857245622;10795.892041079645;10878.728031799268;10949.56201751921;8801.823963520694;8995.910040899638;9110.954445227731;10649.733756656145;10705.46472676363;7110.92889071113;8226.506409615442;8280.089190189074;8290.8341833163;8322.542260175627;4927.876803079808;5038.294638750651;5802.796902108575;5979.252593425822;6076.90884636722;8802.855628768219;9780.462074585681;9934.304598678023;10040.64857729976;10132.594696212363;9442.055794420503;9616.75958101025;10039.297249192487;10340.793184136124;10350.275480716578;7289.562626242442;7560.546367217985;7611.972383728347;7626.466147369631;7639.312461878235;8507.489550626982;8521.275691566287;8590.65637374523;8598.914010859811;8599.484030958163;7529.585872776831;7739.535627862347;7739.535627862347;7749.302562769152;7799.49303295284;7437.51656142349;7451.2176221495965;7501.662425190771;7569.205233450629;7593.1647518774;7054.717811287491;7081;7170.892436613351;7221;7258.129024517092;4896.338994235733;5062.924056139087;5123.231515272739;5141.61437892167;5160.664556803946;5088.109580823415;5095.898082038264;5108.208227724708;5225.346831646044;5246.868828279324 20:06:03 INFO - PROCESS | 1661 | |4;prototype.html;285.53457863682195;311.81758671177363;314.3085212532429;317.3668531280095;321.05449451365706;5769.855753606162;5770.82687519374;5784.1902133701315;5800.970995145024;5820.883582328351;5009.649324547283;5055.545000949914;5406.729663516828;5545.279113715222;5608.775648974046;4077.3883917412477;4214.4099826024385;4263.850765223217;4275.508316543606;4291.4421125253675;3513.0339156731848;4254.723442976212;4256.87229383119;4290.828366865338;4296.97851510742;4221.387898754679;4240.321548552232;4280.400743895857;4285.207236661212;4288.442502474674;3952.150287688161;4224.493060832689;4229.873103806891;4232.343986682069;4284.400183974246;3544.8759293424605;3581.910452238689;3608.899285717855;3613.7109031277696;3629.981850090759;5593.133064374988;5609.803656872031;5615.578831587647;5617.522510586605;5629.71851407432;4381.75900325482;4536.616332018733;4564.406627138484;4614.976925115387;4986.850394488135;4777.761111944389;6005.459508644243;6019.428154325332;6039.9464182177835;6059.727312270914;3971.6624086952643;3988.960110398888;3999.7000224983244;4005.959940400588;4019.376996565537;5582.525485333711;5924.911126333109;6067.575269731121;6276.843078923018;6307.495400368005;3091.2271932016997;3384.729221662261;4015.2170326785995;4052.777097259679;4088.938665919954;4122.958770412258;4129.463169787909;4143.047099167148;4150.605692459211;4169.91660166801;4375.431193944767;4431.911361772746;4599.655025873006;4805.639577031737;4851.175300198975;4666.440027196758;5945.837913460595;5972.283326000907;5982.1455348842;5991.011483105326;1244.153975296807;1337.2310921220337;1391.923444210578;1411.2520364206987;1411.4213172599184;729.8832186850078;857.8412993596205;868.8349213649386;901.8286525560122;932.715521765868;4854.732989685531;5005.724685142352;5332.440093790174;5489.39616642169;5586;4882.096812089775;5171.086697921793;5438.519347617528;5726.484616384545;6077.453029227302;4584.633229341644;5197.167543688699;5365.302510673588;5517.985935133647;5724.227229323988;2707.986460067687;3050.893218737378;3122.406742718876;3226.7741258111705;3268.692522990823;5703.657780533182;5975.715221227457;6064.48451881595;6465.806025819233;6472.831601413579;5714.971305165027;5880.529557635379;6246.3753624637175;6325.066448170434;6386.552941294158;5684.857878553069;6434.391402149463;6435.066915297256;6453.128827608307;6469.708863101172;5837.211976383303;5840.766369345349;6113.205283313141;6169.444749972524;6192.969035154795;5233.398159211587;5954.97022514902;6127.3566275540425;6127.509799215963;6186;5580.469855363734;6027.4876635484725;6270.968645156745;6411.884078254258;6460.644664543495;3688.446732990073;3736.692157744876;3907.6713917268266;3953.2093581284435;3983.422403751382;5065.29085927963;5601.915971260353;6150.415710507495;6158.22879704126;6159.566971046501;5255.78976840922;5443.945560544502;5640.238567793295;5934.43622855828;5993.640381577119;5125.615578831677;5219.556337711337;5403.000889670847;5832.962883415645;5930.466258036625;4825.890045289533;4972.552470277692;5730.624650084033;5806;5824.5631577631;5031.320771695774;5933.940660593339;5961.7615295387695;5988.3532028690715;6013.278406591237;5119.974400127976;5161.793528258828;5224.555912747307;5606.411326810626;5794.304683438015 20:06:03 INFO - PROCESS | 1661 | |5;yui.html;746.6826598695554;766.2950085920952;768.9653965571553;817.963191656375;864.6195673903482;12384.318862462562;15749.527514174579;15833.366665333402;15997.680046399066;16020.919895400535;10919.672409827697;14473.34869930853;14564.344604492797;14580.343884525195;15157.772633410508;702.7224246422686;862.7325529085972;885.4642941020686;896.6054935828247;906.148220672569;904.5522466379118;906.1980147569383;907.1880666803207;910.0580898769774;914.3964983111148;960.5773459677754;963.1379914976092;966.632679581758;968.138356862393;970.8786401699788;946.640276694855;963.2294164668307;963.3401120232663;964.2719746591314;965.1313817564178;697.9790606281769;711.0294448078388;713.9464540159508;714.7998560403096;717.6160753996639;15185.772213416807;15274.77087843672;15285.694286114216;15290.541283761393;15323.693526129526;12712.936435317764;13300.268485233406;13655.795163072562;14111.364988575437;15165.772513412308;13579.59261222165;13752.587422377344;13800.585982420444;14041.508547200901;14109.717805643932;4631.1895418301665;4865.7349089236695;4889.4377146627885;4891.730954797485;4904.435989861176;100814.49592751989;115617.84382156155;116861.41569292184;119494;119528.40235798853;11124.443777811077;11219.66341009771;11244.943775281236;11297.26567773092;11665.825012624817;21846.781532184792;21848.672269915965;21913;21919.01364438604;21919.342419727433;7002.929970700329;8064.112947575762;8118.472299300526;8130.146334634778;8219.589020548949;4532.9320060199125;4580.427446569179;4584.037352156084;4595.195840727859;4708.128996135726;2995.281132528221;3083.6762139975426;3616.0779001354485;3638.8726394576593;3713.405855063177;676.4520738201974;679.78246960973;680.6392611915693;683.5112894280513;699.6187078042377;589.2222266608036;621.586644881158;627.7959663109508;645.8503863123648;662.2979641579941;9073.81852362949;9197.356185067116;9292.860607090899;9295.770439390199;9329.860052099224;540.8026070484245;568.889066632011;621.4189732600033;643.5816719132602;647.6567419267795;4401;4489.9775501122285;4494.775261236925;4498.640108791289;4518.525554816762;150295.24852375887;151272;158264;158913;158925;135332.32333838465;138118;138195;138610;138881;99917.50041249747;117637;118082;120116;124923;8659.48043117415;8694.260987815853;8731.471992401177;8796.028628959968;8982.011978682209;64284.71430571269;64429.355706444214;65263.042108736816;65992.3501912456;66695.66652166708;90339.09660903306;99769;100874.49562752139;101480;104042;11372;11769.588064417705;11772;11776.998955088571;11797.115216358636;12236.816447753114;14995.17526536051;15235.23823808783;15260.694786103993;15313.157776321963;14133.505327313494;14277.28613569338;14304;14455.638609034859;14535.563933082025;14399.640008999859;14473.710525789636;14483.203423811792;14784.039037462531;15099.54701358961;12952.870471295166;13974.650633734238;14137.787933181216;14283.857161428252;14792.63018424548;11648.109992868018;11692.824607631062;11899.226550274205;11971.820422693492;12101.576444824388;9857.556409961713;10703.464826758787;10854.29447085937;11942.4028798558;12106.515739370327 20:06:03 INFO - PROCESS | 1661 | __end_tp_report 20:06:03 INFO - PROCESS | 1661 | __start_cc_report 20:06:03 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,442 20:06:03 INFO - PROCESS | 1661 | __end_cc_report 20:06:03 INFO - PROCESS | 1661 | __startTimestamp1467774363892__endTimestamp 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | ------- Summary: start ------- 20:06:03 INFO - PROCESS | 1661 | Number of tests: 6 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5797.60 Median:6094.17 stddev:640.44 (10.5%) stddev-sans-first:602.16 20:06:03 INFO - PROCESS | 1661 | Values: 2949.0 3392.7 3431.9 3436.8 3459.0 5827.0 5832.4 5850.2 5899.6 5911.0 5699.9 5886.1 5925.8 5972.0 6034.5 5291.2 5330.9 5343.9 5365.9 5386.4 5308.3 5441.3 5455.3 5498.1 5547.6 5217.2 5258.1 5353.0 5385.3 5421.0 5339.2 5345.7 5348.0 5352.7 5372.2 5276.7 5315.4 5351.3 5357.0 5365.2 5170.9 5349.3 5812.0 5875.6 5880.3 6130.1 6171.3 6192.5 6202.4 6206.6 6201.5 6256.5 6266.3 6266.9 6279.4 5830.7 5946.5 6030.1 6035.1 6040.3 6369.0 6422.8 6426.7 6433.3 6439.8 6094.2 6173.3 6189.8 6198.4 6198.8 6129.2 6160.3 6174.4 6219.3 6252.1 6113.1 6143.4 6161.2 6164.4 6195.9 6112.7 6187.3 6187.5 6200.8 6206.1 4936.9 4985.4 5003.6 5007.6 5018.1 4398.8 4415.8 4441.9 4455.9 4496.9 5273.6 5696.8 5804.5 5906.2 5961.1 6208.1 6254.1 6266.6 6278.5 6280.3 5994.2 6004.2 6026.6 6046.9 6054.4 5369.3 5436.3 5458.7 5468.1 5531.8 6302.9 6449.6 6470.9 6488.8 6489.9 5402.8 6213.4 6237.0 6269.2 6341.4 5755.6 6137.8 6241.6 6311.4 6356.0 6168.5 6187.4 6204.3 6217.6 6236.4 5329.8 6116.0 6251.2 6255.8 6272.6 6144.4 6154.7 6159.5 6187.5 6217.8 5130.5 5306.2 6218.6 6226.0 6251.2 6054.7 6082.0 6152.3 6157.1 6203.2 6098.9 6146.8 6149.3 6170.8 6250.0 6106.2 6117.4 6164.3 6166.4 6167.0 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:69364.96 Median:40519.89 stddev:149146.27 (368.1%) stddev-sans-first:149475.05 20:06:03 INFO - PROCESS | 1661 | Values: 506.4 509.9 526.3 557.7 558.7 38405.8 40380.0 40915.0 40916.6 40922.0 36084.5 38540.4 40578.0 41239.0 41239.8 8737.0 9073.2 9536.2 9616.6 9640.7 9632.7 9689.0 9728.5 9736.5 9750.1 9704.5 9734.4 9738.7 9780.6 9824.0 9692.3 9735.0 9744.9 9752.5 9768.3 9627.1 9672.2 9694.2 9723.3 9761.4 39844.6 40079.2 40155.6 40162.6 40437.2 3412.8 3503.1 3554.6 3995.6 4096.0 26940.7 31360.8 31932.8 32195.0 32503.0 3224.5 3278.4 3392.5 3408.1 3408.7 481998.0 485336.0 490401.0 491431.0 494785.5 60979.0 61165.0 61185.0 61270.4 61537.4 62146.0 62411.4 63321.0 63803.7 63851.7 13921.9 14466.6 15708.9 16543.7 16756.8 12698.2 13032.0 13110.0 13112.3 13132.5 15904.8 16521.0 16522.9 16557.5 16624.7 3242.1 6495.2 6656.1 6699.7 6748.0 771.5 987.5 1007.8 1088.1 1102.4 30694.0 30713.5 30889.7 31149.4 31327.4 1077.1 1128.5 1173.1 1176.4 1181.3 14420.8 15166.0 15949.4 16173.8 16338.0 533173.7 624200.0 633452.8 634025.0 635394.0 59629.0 60163.0 60315.7 60427.0 60470.4 1403.2 1411.4 1467.8 1468.2 1471.2 26215.2 29535.0 30646.1 30665.0 31358.8 51241.0 51510.5 52218.7 52380.7 52723.7 563927.0 566067.0 568230.3 568432.0 568943.0 26995.4 27090.9 27212.2 27392.7 27461.9 47869.3 48180.5 48696.0 49025.3 49086.5 39303.8 40699.8 40717.8 40730.6 40909.6 39775.4 40110.0 40461.8 41039.0 41226.6 38356.2 38573.2 39138.6 39373.8 39488.6 31974.0 32165.4 34672.8 35008.0 35340.5 24157.0 24243.7 25813.4 26673.8 26709.5 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33212.91 Median:22243.00 stddev:93403.31 (419.9%) stddev-sans-first:93632.79 20:06:03 INFO - PROCESS | 1661 | Values: 374.3 377.3 385.8 390.4 394.5 18154.5 19616.5 20725.4 21907.0 22033.6 20917.7 21424.0 21758.8 21815.0 21949.0 5521.3 5916.0 6787.6 6797.3 6901.7 6695.2 6789.6 6790.5 6803.3 6829.2 6036.8 6313.9 6726.2 6742.7 6743.2 5702.7 5792.6 5898.5 6415.5 6688.9 4870.2 5725.7 5815.4 5816.2 5842.6 11376.4 15512.8 18828.0 22949.7 24253.0 2173.7 2175.0 2199.6 2279.4 2898.6 10096.3 10175.3 10195.6 10214.6 10291.0 1736.5 1842.9 1867.8 1909.4 1946.8 66478.0 100111.0 110675.4 116837.4 130710.0 11410.6 11416.8 11577.7 11612.8 11780.6 14497.8 14541.9 14562.7 14585.2 14592.6 8499.7 8652.0 8676.5 8713.6 8726.5 8628.5 8690.2 8691.0 8708.9 8784.0 3680.2 4409.0 4477.5 4569.1 4595.0 1778.9 1862.9 1940.4 1942.3 1995.4 833.2 852.9 946.0 977.4 1053.9 20576.0 21805.0 22202.1 22228.1 22257.9 907.8 917.6 933.6 941.9 982.0 11163.6 11641.5 11694.7 11705.9 11706.2 546422.0 548639.0 553583.0 554232.0 601108.0 56269.0 74937.0 114762.4 133556.3 134463.0 995.7 1015.8 1031.8 1051.2 1051.4 19526.8 19784.6 19849.4 19991.6 20055.3 58543.5 59151.0 59271.7 60559.0 61369.0 71284.3 80087.0 83784.2 83788.0 86531.6 6771.5 7321.7 7749.3 7986.7 8026.2 11502.2 12659.8 13270.3 13290.5 13605.6 10692.7 11337.7 11409.9 11461.9 11532.3 11315.7 11325.3 11373.9 11387.2 11450.2 11632.3 11669.4 11683.5 11716.6 11826.9 8064.3 8104.1 8111.0 8181.2 8270.1 8286.5 10400.3 11400.9 11434.6 11528.1 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5705.30 Median:4941.09 stddev:3169.32 (64.1%) stddev-sans-first:3161.80 20:06:03 INFO - PROCESS | 1661 | Values: 1414.3 1566.5 1777.8 1898.7 1920.6 7983.5 8533.4 8680.9 9135.3 9151.7 8667.8 8748.7 8899.2 8911.8 8915.3 2364.1 2375.9 2392.1 2397.3 2403.2 2159.8 2292.4 2307.3 2338.6 2364.3 2346.9 2350.6 2365.9 2379.8 2380.3 2329.6 2343.5 2354.9 2356.1 2364.4 2302.9 2335.8 2342.7 2348.9 2356.1 8901.4 8915.3 8950.8 9035.6 9045.3 5302.3 5365.7 5434.5 5450.8 5453.1 3592.0 3668.6 3669.8 3744.8 3751.0 1074.9 1089.0 1101.9 1114.4 1115.8 9716.2 11579.0 11752.2 11762.2 11780.4 4629.7 4669.3 4856.3 4866.0 4868.5 9918.3 10046.7 10050.0 10071.3 10073.9 5374.5 5419.6 5420.6 5425.7 5439.0 4392.4 4739.5 4891.6 4916.7 4954.3 3405.4 3989.5 4088.0 4093.2 4135.9 1300.4 1300.8 1308.8 1311.1 1322.3 902.6 916.5 920.5 942.5 969.5 5717.4 5831.4 5885.9 6050.6 6093.3 431.9 445.5 445.7 455.5 462.2 3860.3 4008.0 4053.0 4086.2 4102.8 10074.2 10778.6 10795.9 10878.7 10949.6 8801.8 8995.9 9111.0 10649.7 10705.5 7110.9 8226.5 8280.1 8290.8 8322.5 4927.9 5038.3 5802.8 5979.3 6076.9 8802.9 9780.5 9934.3 10040.6 10132.6 9442.1 9616.8 10039.3 10340.8 10350.3 7289.6 7560.5 7612.0 7626.5 7639.3 8507.5 8521.3 8590.7 8598.9 8599.5 7529.6 7739.5 7739.5 7749.3 7799.5 7437.5 7451.2 7501.7 7569.2 7593.2 7054.7 7081.0 7170.9 7221.0 7258.1 4896.3 5062.9 5123.2 5141.6 5160.7 5088.1 5095.9 5108.2 5225.3 5246.9 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4761.60 Median:5294.11 stddev:1492.59 (28.2%) stddev-sans-first:1458.47 20:06:03 INFO - PROCESS | 1661 | Values: 285.5 311.8 314.3 317.4 321.1 5769.9 5770.8 5784.2 5801.0 5820.9 5009.6 5055.5 5406.7 5545.3 5608.8 4077.4 4214.4 4263.9 4275.5 4291.4 3513.0 4254.7 4256.9 4290.8 4297.0 4221.4 4240.3 4280.4 4285.2 4288.4 3952.2 4224.5 4229.9 4232.3 4284.4 3544.9 3581.9 3608.9 3613.7 3630.0 5593.1 5609.8 5615.6 5617.5 5629.7 4381.8 4536.6 4564.4 4615.0 4986.9 4777.8 6005.5 6019.4 6039.9 6059.7 3971.7 3989.0 3999.7 4006.0 4019.4 5582.5 5924.9 6067.6 6276.8 6307.5 3091.2 3384.7 4015.2 4052.8 4088.9 4123.0 4129.5 4143.0 4150.6 4169.9 4375.4 4431.9 4599.7 4805.6 4851.2 4666.4 5945.8 5972.3 5982.1 5991.0 1244.2 1337.2 1391.9 1411.3 1411.4 729.9 857.8 868.8 901.8 932.7 4854.7 5005.7 5332.4 5489.4 5586.0 4882.1 5171.1 5438.5 5726.5 6077.5 4584.6 5197.2 5365.3 5518.0 5724.2 2708.0 3050.9 3122.4 3226.8 3268.7 5703.7 5975.7 6064.5 6465.8 6472.8 5715.0 5880.5 6246.4 6325.1 6386.6 5684.9 6434.4 6435.1 6453.1 6469.7 5837.2 5840.8 6113.2 6169.4 6193.0 5233.4 5955.0 6127.4 6127.5 6186.0 5580.5 6027.5 6271.0 6411.9 6460.6 3688.4 3736.7 3907.7 3953.2 3983.4 5065.3 5601.9 6150.4 6158.2 6159.6 5255.8 5443.9 5640.2 5934.4 5993.6 5125.6 5219.6 5403.0 5833.0 5930.5 4825.9 4972.6 5730.6 5806.0 5824.6 5031.3 5933.9 5961.8 5988.4 6013.3 5120.0 5161.8 5224.6 5606.4 5794.3 20:06:03 INFO - PROCESS | 1661 | 20:06:03 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:26013.28 Median:12457.31 stddev:41916.11 (336.5%) stddev-sans-first:41990.77 20:06:03 INFO - PROCESS | 1661 | Values: 746.7 766.3 769.0 818.0 864.6 12384.3 15749.5 15833.4 15997.7 16020.9 10919.7 14473.3 14564.3 14580.3 15157.8 702.7 862.7 885.5 896.6 906.1 904.6 906.2 907.2 910.1 914.4 960.6 963.1 966.6 968.1 970.9 946.6 963.2 963.3 964.3 965.1 698.0 711.0 713.9 714.8 717.6 15185.8 15274.8 15285.7 15290.5 15323.7 12712.9 13300.3 13655.8 14111.4 15165.8 13579.6 13752.6 13800.6 14041.5 14109.7 4631.2 4865.7 4889.4 4891.7 4904.4 100814.5 115617.8 116861.4 119494.0 119528.4 11124.4 11219.7 11244.9 11297.3 11665.8 21846.8 21848.7 21913.0 21919.0 21919.3 7002.9 8064.1 8118.5 8130.1 8219.6 4532.9 4580.4 4584.0 4595.2 4708.1 2995.3 3083.7 3616.1 3638.9 3713.4 676.5 679.8 680.6 683.5 699.6 589.2 621.6 627.8 645.9 662.3 9073.8 9197.4 9292.9 9295.8 9329.9 540.8 568.9 621.4 643.6 647.7 4401.0 4490.0 4494.8 4498.6 4518.5 150295.2 151272.0 158264.0 158913.0 158925.0 135332.3 138118.0 138195.0 138610.0 138881.0 99917.5 117637.0 118082.0 120116.0 124923.0 8659.5 8694.3 8731.5 8796.0 8982.0 64284.7 64429.4 65263.0 65992.4 66695.7 90339.1 99769.0 100874.5 101480.0 104042.0 11372.0 11769.6 11772.0 11777.0 11797.1 12236.8 14995.2 15235.2 15260.7 15313.2 14133.5 14277.3 14304.0 14455.6 14535.6 14399.6 14473.7 14483.2 14784.0 15099.5 12952.9 13974.7 14137.8 14283.9 14792.6 11648.1 11692.8 11899.2 11971.8 12101.6 9857.6 10703.5 10854.3 11942.4 12106.5 20:06:03 INFO - PROCESS | 1661 | -------- Summary: end -------- 20:06:03 INFO - PROCESS | 1661 | 20:06:04 INFO - TEST-INFO | 1661: exit 0 20:06:04 INFO - TEST-OK | dromaeo_css | took 1113390ms 20:06:04 INFO - TEST-START | kraken 20:06:04 INFO - operating with platform_type : mac_ 20:06:04 INFO - Initialising browser for kraken test... 20:06:04 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmphNujsq/profile http://localhost:49275/getInfo.html) 20:06:07 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 20:06:07 INFO - PROCESS | 1668 | colorDepth:24 20:06:07 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 20:06:07 INFO - PROCESS | 1668 | __metrics 20:06:07 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 20:06:08 INFO - TEST-INFO | 1668: exit 0 20:06:08 INFO - Browser initialized. 20:06:08 INFO - Running cycle 1/1 for kraken test... 20:06:08 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/T/tmphNujsq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:20 INFO - PROCESS | 1670 | RSS: Main: 255848448 20:06:20 INFO - PROCESS | 1670 | 20:06:23 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 20:06:24 INFO - PROCESS | 1670 | RSS: Main: 268505088 20:06:24 INFO - PROCESS | 1670 | 20:06:26 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 20:06:27 INFO - PROCESS | 1670 | RSS: Main: 273014784 20:06:27 INFO - PROCESS | 1670 | 20:06:30 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 20:06:31 INFO - PROCESS | 1670 | RSS: Main: 272941056 20:06:31 INFO - PROCESS | 1670 | 20:06:33 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 20:06:34 INFO - PROCESS | 1670 | RSS: Main: 273936384 20:06:34 INFO - PROCESS | 1670 | 20:06:36 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:06:36 INFO - PROCESS | 1670 | RSS: Main: 274718720 20:06:36 INFO - PROCESS | 1670 | 20:06:39 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 20:06:40 INFO - PROCESS | 1670 | RSS: Main: 275267584 20:06:40 INFO - PROCESS | 1670 | 20:06:43 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 20:06:44 INFO - PROCESS | 1670 | RSS: Main: 275492864 20:06:44 INFO - PROCESS | 1670 | 20:06:47 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 20:06:47 INFO - PROCESS | 1670 | RSS: Main: 275607552 20:06:47 INFO - PROCESS | 1670 | 20:06:49 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:06:50 INFO - PROCESS | 1670 | RSS: Main: 275243008 20:06:50 INFO - PROCESS | 1670 | 20:06:51 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:06:52 INFO - PROCESS | 1670 | RSS: Main: 275206144 20:06:52 INFO - PROCESS | 1670 | 20:06:54 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:06:55 INFO - PROCESS | 1670 | RSS: Main: 275554304 20:06:55 INFO - PROCESS | 1670 | 20:06:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:06:59 INFO - PROCESS | 1670 | RSS: Main: 275734528 20:06:59 INFO - PROCESS | 1670 | 20:07:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:07:02 INFO - PROCESS | 1670 | RSS: Main: 275554304 20:07:02 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 20:07:04 INFO - PROCESS | 1670 | RSS: Main: 276664320 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | __start_tp_report 20:07:04 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 20:07:04 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 20:07:04 INFO - PROCESS | 1670 | |i|pagename|runs| 20:07:04 INFO - PROCESS | 1670 | |0;ai-astar;104;143;152;155;117;114;113;115;114;114 20:07:04 INFO - PROCESS | 1670 | |1;audio-beat-detection;143;123;120;190;134;162;125;114;192;98 20:07:04 INFO - PROCESS | 1670 | |2;audio-dft;200;219;209;200;211;204;201;194;198;197 20:07:04 INFO - PROCESS | 1670 | |3;audio-fft;70;75;75;141;58;59;60;62;143;70 20:07:04 INFO - PROCESS | 1670 | |4;audio-oscillator;70;73;123;98;98;73;112;66;71;113 20:07:04 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;80;75;77;80;84;129;77;94;90;128 20:07:04 INFO - PROCESS | 1670 | |6;imaging-darkroom;148;93;152;156;95;96;97;99;119;110 20:07:04 INFO - PROCESS | 1670 | |7;imaging-desaturate;97;95;115;139;87;137;144;107;94;92 20:07:04 INFO - PROCESS | 1670 | |8;json-parse-financial;54;56;59;55;59;53;54;54;55;58 20:07:04 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;68;72;73;67;90;106;70;67;74;69 20:07:04 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;83;83;85;87;84;84;85;84;75 20:07:04 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;144;134;132;164;151;144;150;154;214;148 20:07:04 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;172;169;163;164;167;161;165;167;164;166 20:07:04 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;66;69;64;66;69;64;68;65;67;64 20:07:04 INFO - PROCESS | 1670 | __end_tp_report 20:07:04 INFO - PROCESS | 1670 | __start_cc_report 20:07:04 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1133 20:07:04 INFO - PROCESS | 1670 | __end_cc_report 20:07:04 INFO - PROCESS | 1670 | __startTimestamp1467774424426__endTimestamp 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | ------- Summary: start ------- 20:07:04 INFO - PROCESS | 1670 | Number of tests: 14 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:124.10 Median:116.00 stddev:18.43 (15.9%) stddev-sans-first:18.06 20:07:04 INFO - PROCESS | 1670 | Values: 104.0 143.0 152.0 155.0 117.0 114.0 113.0 115.0 114.0 114.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:152.50 stddev:31.78 (20.8%) stddev-sans-first:33.69 20:07:04 INFO - PROCESS | 1670 | Values: 143.0 123.0 120.0 190.0 134.0 162.0 125.0 114.0 192.0 98.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:203.30 Median:202.50 stddev:7.60 (3.8%) stddev-sans-first:7.97 20:07:04 INFO - PROCESS | 1670 | Values: 200.0 219.0 209.0 200.0 211.0 204.0 201.0 194.0 198.0 197.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:81.30 Median:66.00 stddev:32.61 (49.4%) stddev-sans-first:34.33 20:07:04 INFO - PROCESS | 1670 | Values: 70.0 75.0 75.0 141.0 58.0 59.0 60.0 62.0 143.0 70.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:72.00 stddev:21.46 (29.8%) stddev-sans-first:21.54 20:07:04 INFO - PROCESS | 1670 | Values: 70.0 73.0 123.0 98.0 98.0 73.0 112.0 66.0 71.0 113.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:91.40 Median:80.00 stddev:20.44 (25.6%) stddev-sans-first:21.26 20:07:04 INFO - PROCESS | 1670 | Values: 80.0 75.0 77.0 80.0 84.0 129.0 77.0 94.0 90.0 128.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:94.00 stddev:25.78 (27.4%) stddev-sans-first:24.70 20:07:04 INFO - PROCESS | 1670 | Values: 148.0 93.0 152.0 156.0 95.0 96.0 97.0 99.0 119.0 110.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:110.70 Median:89.50 stddev:21.75 (24.3%) stddev-sans-first:22.50 20:07:04 INFO - PROCESS | 1670 | Values: 97.0 95.0 115.0 139.0 87.0 137.0 144.0 107.0 94.0 92.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:55.50 stddev:2.21 (4.0%) stddev-sans-first:2.26 20:07:04 INFO - PROCESS | 1670 | Values: 54.0 56.0 59.0 55.0 59.0 53.0 54.0 54.0 55.0 58.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:75.60 Median:71.00 stddev:12.62 (17.8%) stddev-sans-first:13.09 20:07:04 INFO - PROCESS | 1670 | Values: 68.0 72.0 73.0 67.0 90.0 106.0 70.0 67.0 74.0 69.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:84.50 stddev:3.37 (4.0%) stddev-sans-first:3.35 20:07:04 INFO - PROCESS | 1670 | Values: 87.0 83.0 83.0 85.0 87.0 84.0 84.0 85.0 84.0 75.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:153.50 Median:150.50 stddev:23.20 (15.4%) stddev-sans-first:24.35 20:07:04 INFO - PROCESS | 1670 | Values: 144.0 134.0 132.0 164.0 151.0 144.0 150.0 154.0 214.0 148.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.80 Median:166.50 stddev:3.16 (1.9%) stddev-sans-first:2.42 20:07:04 INFO - PROCESS | 1670 | Values: 172.0 169.0 163.0 164.0 167.0 161.0 165.0 167.0 164.0 166.0 20:07:04 INFO - PROCESS | 1670 | 20:07:04 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.99 (3.0%) stddev-sans-first:2.11 20:07:04 INFO - PROCESS | 1670 | Values: 66.0 69.0 64.0 66.0 69.0 64.0 68.0 65.0 67.0 64.0 20:07:04 INFO - PROCESS | 1670 | -------- Summary: end -------- 20:07:04 INFO - PROCESS | 1670 | 20:07:05 INFO - TEST-INFO | 1670: exit 0 20:07:05 INFO - TEST-OK | kraken | took 60714ms 20:07:05 INFO - SUITE-END | took 1174s 20:07:05 INFO - Completed test suite (00:19:34) 20:07:05 INFO - javascript benchmark 20:07:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7467.572059340497, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2948.970510294899, 3392.694657480826, 3431.8798842040533, 3436.7766095203815, 3459.0, 5826.9999999999945, 5832.387599302076, 5850.180974663545, 5899.616524925877, 5910.970445147774, 5699.943000569993, 5886.058230683092, 5925.785214031124, 5971.954907891112, 6034.5172386209, 5291.206319052135, 5330.920036199441, 5343.946560534394, 5365.865853353678, 5386.353637563498, 5308.309919710432, 5441.29263195784, 5455.263539422187, 5498.0653288940775, 5547.583931205176, 5217.191335343028, 5258.079836028718, 5352.973235133838, 5385.2999110115825, 5421.024215641183, 5339.225812257239, 5345.732713364317, 5347.973260133675, 5352.652077614943, 5372.2210279509645, 5276.709780962045, 5315.388730295988, 5351.331083614548, 5356.95539369823, 5365.248865158881, 5170.922436163461, 5349.277847490578, 5812.041013232812, 5875.559333049996, 5880.294364676223, 6130.111133885606, 6171.321154672983, 6192.504599632019, 6202.441780239755, 6206.596571222856, 6201.45009031963, 6256.499480041586, 6266.279377871558, 6266.934621114421, 6279.434850863398, 5830.650160990354, 5946.464818166386, 6030.125631783455, 6035.124906888476, 6040.335563088057, 6369.0, 6422.775202867971, 6426.678666066771, 6433.324500927429, 6439.774607888701, 6094.169091873587, 6173.32093469718, 6189.84525386869, 6198.442140207403, 6198.783042593487, 6129.23653806838, 6160.260768707783, 6174.351693072253, 6219.253689557192, 6252.124702541648, 6113.113598528189, 6143.354947730513, 6161.229846269216, 6164.352742962014, 6195.876082478325, 6112.74665817949, 6187.319394866561, 6187.535934804908, 6200.844978875564, 6206.100115483229, 4936.925946110811, 4985.4017517897355, 5003.5997120230295, 5007.574356179693, 5018.121828679967, 4398.824047038082, 4415.823367065345, 4441.911161776811, 4455.910881782346, 4496.9325460118125, 5273.630845840831, 5696.772129114789, 5804.506616937608, 5906.173135760997, 5961.076033214772, 6208.099825525273, 6254.061890716338, 6266.561340706198, 6278.529110316745, 6280.2777680566405, 5994.220751302303, 6004.189434426296, 6026.578139530191, 6046.881326954527, 6054.364291749391, 5369.275147855068, 5436.3476382834315, 5458.727063646802, 5468.097763868917, 5531.751071201806, 6302.905456418157, 6449.613023218434, 6470.935290647033, 6488.772892948724, 6489.902651460137, 5402.837914862561, 6213.440790328892, 6236.968815155895, 6269.247690277196, 6341.397567231105, 5755.568332375173, 6137.772445510826, 6241.625502469867, 6311.400416960381, 6356.0, 6168.506519478341, 6187.443130118311, 6204.348543402878, 6217.564770466205, 6236.376362363727, 5329.813456529003, 6116.021436570128, 6251.187345645219, 6255.781047663492, 6272.5922815016875, 6144.354842741448, 6154.661493617894, 6159.5072394209255, 6187.535934804818, 6217.782377616762, 5130.51260130287, 5306.204069389622, 6218.626882387071, 6226.0, 6251.218597675291, 6054.66699331541, 6082.0, 6152.292486363946, 6157.138000679998, 6203.16257305258, 6098.908516372347, 6146.754129834757, 6149.2620885494025, 6170.753169873335, 6250.0, 6106.236720409949, 6117.449429551361, 6164.321924588381, 6166.383361663977, 6167.044108163242], "value": 5757.122653571833, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.382213699287, 509.93880734311887, 526.3210458508524, 557.707203718048, 558.678759713165, 38405.807970960144, 40380.0, 40914.97712557187, 40916.56792012276, 40922.0, 36084.45873311896, 38540.42189367155, 40577.98555036118, 41239.0, 41239.793801031024, 8736.956315218447, 9073.228775554086, 9536.188124256403, 9616.567254473566, 9640.71077867665, 9632.662856800014, 9689.0, 9728.464934428604, 9736.51317434129, 9750.12248897599, 9704.466254356008, 9734.415935043884, 9738.707838764813, 9780.55987480565, 9823.95088024559, 9692.27307951903, 9734.951325243364, 9744.90255097447, 9752.512374381324, 9768.316217864753, 9627.133557979745, 9672.22622190223, 9694.22446204309, 9723.270754693427, 9761.414315141043, 39844.60155398438, 40079.19841603152, 40155.59844401548, 40162.598374016474, 40437.19125617471, 3412.7611067225303, 3503.1242189452637, 3554.573451185848, 3995.580464051262, 4096.016955930585, 26940.730592694017, 31360.843195783877, 31932.840335798406, 32195.034148975566, 32503.0, 3224.5324427957817, 3278.393497203025, 3392.4911263310455, 3408.1479630092476, 3408.6932176104024, 481998.0, 485336.0, 490401.0, 491431.0, 494785.52607237094, 60979.0, 61165.0, 61185.0, 61270.38729612736, 61537.384626153165, 62146.0, 62411.37588624146, 63321.0, 63803.68098159479, 63851.68074159599, 13921.886249100047, 14466.566003019927, 15708.92145539265, 16543.6691266174, 16756.827022108337, 12698.238105713686, 13032.0, 13110.0, 13112.344382780822, 13132.540361087316, 15904.840951590568, 16521.00873947543, 16522.917385413235, 16557.503274901774, 16624.6675066498, 3242.124626350872, 6495.1556297681, 6656.101426307387, 6699.698513566901, 6748.0, 771.5293670860771, 987.4618333008527, 1007.8034783217349, 1088.1458055426451, 1102.4267380961855, 30694.0, 30713.539296910563, 30889.69110308913, 31149.377012459623, 31327.37345253082, 1077.106002018323, 1128.470921900829, 1173.12015988009, 1176.3823992404057, 1181.3207405741562, 14420.783688244685, 15166.0, 15949.44176953801, 16173.838261617468, 16338.039435267843, 533173.6730530813, 624200.0, 633452.8327358426, 634025.0, 635394.0, 59629.0, 60163.0, 60315.69842150849, 60427.0, 60470.395296047354, 1403.1791402029723, 1411.4354258296764, 1467.7651575748043, 1468.155810409019, 1471.1908450352264, 26215.213543593723, 29535.0, 30646.08061758151, 30665.0, 31358.843205783825, 51241.0, 51510.48489515057, 52218.738906305225, 52380.73809630927, 52723.736381317845, 563927.0, 566067.0, 568230.3176968343, 568432.0, 568943.0, 26995.38027718343, 27090.864545677145, 27212.183634490204, 27392.726072739017, 27461.86269068642, 47869.28196076992, 48180.5181948176, 48696.0, 49025.26462103, 49086.509134909626, 39303.80348098241, 40699.79650101731, 40717.796411017756, 40730.59269407268, 40909.590904090575, 39775.40336894891, 40110.0, 40461.78614641565, 41038.9740256496, 41226.58773412347, 38356.232875342896, 38573.2285354297, 39138.60861391349, 39373.80313098531, 39488.60511394849, 31974.0, 32165.356692865542, 34672.82663586767, 35008.0, 35340.469892951114, 24157.0, 24243.666598337262, 25813.418658134036, 26673.799679014104, 26709.465810684065], "value": 20059.015299531526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.262702476122, 377.3415390144197, 385.8186652273432, 390.4202259644426, 394.52065740125744, 18154.5461363466, 19616.509587260327, 20725.378238652826, 21907.0, 22033.559328813433, 20917.686234706493, 21424.03591838367, 21758.78241217591, 21815.0, 21949.0, 5521.309836270466, 5916.0238560637445, 6787.5588086774205, 6797.28628494006, 6901.654917254143, 6695.196576410837, 6789.558678685894, 6790.490713196506, 6803.285655006227, 6829.180498340206, 6036.788712395067, 6313.905291420632, 6726.159230096238, 6742.730290788362, 6743.224529179158, 5702.714864256771, 5792.594518383715, 5898.469137777599, 6415.518836087289, 6688.86622267552, 4870.245112007609, 5725.685087320196, 5815.389384114649, 5816.185733997244, 5842.591018628697, 11376.374299413528, 15512.844871551253, 18828.0, 22949.655755163687, 24253.0, 2173.673948907661, 2174.9782502175094, 2199.56008798241, 2279.3959600705825, 2898.565150527321, 10096.29325947184, 10175.287729858914, 10195.592176312939, 10214.642487512901, 10291.0, 1736.5311365931127, 1842.9262829486804, 1867.766529183852, 1909.3699079303797, 1946.8247857692734, 66478.0, 100111.0, 110675.44662276718, 116837.41581292124, 130710.0, 11410.600628977945, 11416.828747568794, 11577.6526704199, 11612.825807612893, 11780.646580602595, 14497.782533262009, 14541.927290363692, 14562.708745825024, 14585.197814120113, 14592.63518412027, 8499.74500764978, 8651.95674021626, 8676.522791246542, 8713.564321783886, 8726.476411415208, 8628.482291062557, 8690.174433428814, 8690.956545217234, 8708.911386076741, 8784.0, 3680.1719613086843, 4408.955910440919, 4477.507474177838, 4569.13186494565, 4595.035042641083, 1778.9377371792184, 1862.8729618580835, 1940.427573865713, 1942.3201879342116, 1995.3714579907282, 833.2084519706303, 852.863541833316, 945.976350591227, 977.3940157102642, 1053.8946105389552, 20576.0, 21805.0, 22202.11191552352, 22228.11087556512, 22257.888710556344, 907.7685190276569, 917.6448436981323, 933.6265493802533, 941.9293552983554, 981.9558119884622, 11163.609273675382, 11641.53433862653, 11694.661067786306, 11705.88294117065, 11706.180567360203, 546422.0, 548639.0, 553583.0, 554232.0, 601108.0, 56269.0, 74937.0, 114762.42618786852, 133556.3322183383, 134463.0, 995.6807230419723, 1015.7663737340305, 1031.8091153136543, 1051.164324362134, 1051.4374809477047, 19526.8047319525, 19784.604307913472, 19849.40451786449, 19991.60016799685, 20055.29806456767, 58543.53641158835, 59151.0, 59271.703641481516, 60559.0, 61369.0, 71284.28715712776, 80087.0, 83784.16215837763, 83788.0, 86531.56734216289, 6771.458283337222, 7321.707131714885, 7749.302562769378, 7986.720464783704, 8026.197380261927, 11502.19484636101, 12659.810102848649, 13270.270135142273, 13290.534831280858, 13605.591832245049, 10692.732681683021, 11337.659870203906, 11409.942950285527, 11461.942690286494, 11532.25040372373, 11315.660530184108, 11325.32048077118, 11373.943130284295, 11387.202895797545, 11450.198486106226, 11632.302061876315, 11669.35818529989, 11683.474243658886, 11716.589919352782, 11826.940865295963, 8064.274215320649, 8104.108548059591, 8110.959445202736, 8181.222783835526, 8270.137221098204, 8286.502809831429, 10400.27198096126, 11400.885991140314, 11434.599789007345, 11528.135389845627], "value": 9610.464390522919, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1414.2716501001985, 1566.5457017464933, 1777.8399944005037, 1898.743669604603, 1920.5582715975324, 7983.52098874068, 8533.445326053803, 8680.869786953193, 9135.314851386147, 9151.725448236546, 8667.826643467128, 8748.650053997833, 8899.243564297043, 8911.821763564725, 8915.286777057836, 2364.1252736487436, 2375.893084811179, 2392.0790495659207, 2397.280815755275, 2403.194929698553, 2159.8380121490873, 2292.403974966504, 2307.284741730061, 2338.614128668776, 2364.290712786166, 2346.9295921122393, 2350.6239001759723, 2365.899856566696, 2379.7858192762646, 2380.2978121454125, 2329.592321343758, 2343.4610039690883, 2354.8940297686645, 2356.069352605711, 2364.4207169243473, 2302.873341966191, 2335.8131349492, 2342.6603142544404, 2348.894299756515, 2356.081128359941, 8901.376903616685, 8915.28677705782, 8950.776230594221, 9035.593398297093, 9045.321600879895, 5302.2841916341185, 5365.678059316415, 5434.456554344534, 5450.809221677222, 5453.127499600045, 3591.982040089809, 3668.633136686337, 3669.7981611011382, 3744.7753134811996, 3750.981245093757, 1074.8602681651414, 1088.9945550272278, 1101.911847052234, 1114.3648120571277, 1115.7991561518922, 9716.222702183879, 11579.0, 11752.177347585672, 11762.235454695418, 11780.410979451079, 4629.6990695605355, 4669.322948172564, 4856.3201151838775, 4865.9756701216265, 4868.513148685103, 9918.30571859963, 10046.69859904204, 10050.0, 10071.34536255141, 10073.899261007442, 5374.4625537445945, 5419.566434685215, 5420.620556561003, 5425.728713564306, 5438.993786149575, 4392.428984232093, 4739.526047395302, 4891.584215341664, 4916.655834091579, 4954.3063971044085, 3405.370006548747, 3989.4813674222746, 4087.9795601021806, 4093.242750091183, 4135.91728165435, 1300.408314217048, 1300.7723648361498, 1308.7644224039764, 1311.0560396514495, 1322.3388305847077, 902.6434558349415, 916.4592890194817, 920.5075284722641, 942.4863449420083, 969.5491596407704, 5717.399673034354, 5831.387704290988, 5885.852853678693, 6050.606710563799, 6093.29927058394, 431.8704388683382, 445.5321911992395, 445.66797735687123, 455.4602795687121, 462.22115734986653, 3860.285847118292, 4007.979960100181, 4053.0272734543496, 4086.223617512663, 4102.774347410921, 10074.194064474825, 10778.568857245622, 10795.892041079645, 10878.728031799268, 10949.56201751921, 8801.823963520694, 8995.910040899638, 9110.954445227731, 10649.733756656145, 10705.46472676363, 7110.92889071113, 8226.506409615442, 8280.089190189074, 8290.8341833163, 8322.542260175627, 4927.876803079808, 5038.294638750651, 5802.796902108575, 5979.252593425822, 6076.90884636722, 8802.855628768219, 9780.462074585681, 9934.304598678023, 10040.64857729976, 10132.594696212363, 9442.055794420503, 9616.75958101025, 10039.297249192487, 10340.793184136124, 10350.275480716578, 7289.562626242442, 7560.546367217985, 7611.972383728347, 7626.466147369631, 7639.312461878235, 8507.489550626982, 8521.275691566287, 8590.65637374523, 8598.914010859811, 8599.484030958163, 7529.585872776831, 7739.535627862347, 7739.535627862347, 7749.302562769152, 7799.49303295284, 7437.51656142349, 7451.2176221495965, 7501.662425190771, 7569.205233450629, 7593.1647518774, 7054.717811287491, 7081.0, 7170.892436613351, 7221.0, 7258.129024517092, 4896.338994235733, 5062.924056139087, 5123.231515272739, 5141.61437892167, 5160.664556803946, 5088.109580823415, 5095.898082038264, 5108.208227724708, 5225.346831646044, 5246.868828279324], "value": 4529.925973713928, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.53457863682195, 311.81758671177363, 314.3085212532429, 317.3668531280095, 321.05449451365706, 5769.855753606162, 5770.82687519374, 5784.1902133701315, 5800.970995145024, 5820.883582328351, 5009.649324547283, 5055.545000949914, 5406.729663516828, 5545.279113715222, 5608.775648974046, 4077.3883917412477, 4214.4099826024385, 4263.850765223217, 4275.508316543606, 4291.4421125253675, 3513.0339156731848, 4254.723442976212, 4256.87229383119, 4290.828366865338, 4296.97851510742, 4221.387898754679, 4240.321548552232, 4280.400743895857, 4285.207236661212, 4288.442502474674, 3952.150287688161, 4224.493060832689, 4229.873103806891, 4232.343986682069, 4284.400183974246, 3544.8759293424605, 3581.910452238689, 3608.899285717855, 3613.7109031277696, 3629.981850090759, 5593.133064374988, 5609.803656872031, 5615.578831587647, 5617.522510586605, 5629.71851407432, 4381.75900325482, 4536.616332018733, 4564.406627138484, 4614.976925115387, 4986.850394488135, 4777.761111944389, 6005.459508644243, 6019.428154325332, 6039.9464182177835, 6059.727312270914, 3971.6624086952643, 3988.960110398888, 3999.7000224983244, 4005.959940400588, 4019.376996565537, 5582.525485333711, 5924.911126333109, 6067.575269731121, 6276.843078923018, 6307.495400368005, 3091.2271932016997, 3384.729221662261, 4015.2170326785995, 4052.777097259679, 4088.938665919954, 4122.958770412258, 4129.463169787909, 4143.047099167148, 4150.605692459211, 4169.91660166801, 4375.431193944767, 4431.911361772746, 4599.655025873006, 4805.639577031737, 4851.175300198975, 4666.440027196758, 5945.837913460595, 5972.283326000907, 5982.1455348842, 5991.011483105326, 1244.153975296807, 1337.2310921220337, 1391.923444210578, 1411.2520364206987, 1411.4213172599184, 729.8832186850078, 857.8412993596205, 868.8349213649386, 901.8286525560122, 932.715521765868, 4854.732989685531, 5005.724685142352, 5332.440093790174, 5489.39616642169, 5586.0, 4882.096812089775, 5171.086697921793, 5438.519347617528, 5726.484616384545, 6077.453029227302, 4584.633229341644, 5197.167543688699, 5365.302510673588, 5517.985935133647, 5724.227229323988, 2707.986460067687, 3050.893218737378, 3122.406742718876, 3226.7741258111705, 3268.692522990823, 5703.657780533182, 5975.715221227457, 6064.48451881595, 6465.806025819233, 6472.831601413579, 5714.971305165027, 5880.529557635379, 6246.3753624637175, 6325.066448170434, 6386.552941294158, 5684.857878553069, 6434.391402149463, 6435.066915297256, 6453.128827608307, 6469.708863101172, 5837.211976383303, 5840.766369345349, 6113.205283313141, 6169.444749972524, 6192.969035154795, 5233.398159211587, 5954.97022514902, 6127.3566275540425, 6127.509799215963, 6186.0, 5580.469855363734, 6027.4876635484725, 6270.968645156745, 6411.884078254258, 6460.644664543495, 3688.446732990073, 3736.692157744876, 3907.6713917268266, 3953.2093581284435, 3983.422403751382, 5065.29085927963, 5601.915971260353, 6150.415710507495, 6158.22879704126, 6159.566971046501, 5255.78976840922, 5443.945560544502, 5640.238567793295, 5934.43622855828, 5993.640381577119, 5125.615578831677, 5219.556337711337, 5403.000889670847, 5832.962883415645, 5930.466258036625, 4825.890045289533, 4972.552470277692, 5730.624650084033, 5806.0, 5824.5631577631, 5031.320771695774, 5933.940660593339, 5961.7615295387695, 5988.3532028690715, 6013.278406591237, 5119.974400127976, 5161.793528258828, 5224.555912747307, 5606.411326810626, 5794.304683438015], "value": 4276.54093138758, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.6826598695554, 766.2950085920952, 768.9653965571553, 817.963191656375, 864.6195673903482, 12384.318862462562, 15749.527514174579, 15833.366665333402, 15997.680046399066, 16020.919895400535, 10919.672409827697, 14473.34869930853, 14564.344604492797, 14580.343884525195, 15157.772633410508, 702.7224246422686, 862.7325529085972, 885.4642941020686, 896.6054935828247, 906.148220672569, 904.5522466379118, 906.1980147569383, 907.1880666803207, 910.0580898769774, 914.3964983111148, 960.5773459677754, 963.1379914976092, 966.632679581758, 968.138356862393, 970.8786401699788, 946.640276694855, 963.2294164668307, 963.3401120232663, 964.2719746591314, 965.1313817564178, 697.9790606281769, 711.0294448078388, 713.9464540159508, 714.7998560403096, 717.6160753996639, 15185.772213416807, 15274.77087843672, 15285.694286114216, 15290.541283761393, 15323.693526129526, 12712.936435317764, 13300.268485233406, 13655.795163072562, 14111.364988575437, 15165.772513412308, 13579.59261222165, 13752.587422377344, 13800.585982420444, 14041.508547200901, 14109.717805643932, 4631.1895418301665, 4865.7349089236695, 4889.4377146627885, 4891.730954797485, 4904.435989861176, 100814.49592751989, 115617.84382156155, 116861.41569292184, 119494.0, 119528.40235798853, 11124.443777811077, 11219.66341009771, 11244.943775281236, 11297.26567773092, 11665.825012624817, 21846.781532184792, 21848.672269915965, 21913.0, 21919.01364438604, 21919.342419727433, 7002.929970700329, 8064.112947575762, 8118.472299300526, 8130.146334634778, 8219.589020548949, 4532.9320060199125, 4580.427446569179, 4584.037352156084, 4595.195840727859, 4708.128996135726, 2995.281132528221, 3083.6762139975426, 3616.0779001354485, 3638.8726394576593, 3713.405855063177, 676.4520738201974, 679.78246960973, 680.6392611915693, 683.5112894280513, 699.6187078042377, 589.2222266608036, 621.586644881158, 627.7959663109508, 645.8503863123648, 662.2979641579941, 9073.81852362949, 9197.356185067116, 9292.860607090899, 9295.770439390199, 9329.860052099224, 540.8026070484245, 568.889066632011, 621.4189732600033, 643.5816719132602, 647.6567419267795, 4401.0, 4489.9775501122285, 4494.775261236925, 4498.640108791289, 4518.525554816762, 150295.24852375887, 151272.0, 158264.0, 158913.0, 158925.0, 135332.32333838465, 138118.0, 138195.0, 138610.0, 138881.0, 99917.50041249747, 117637.0, 118082.0, 120116.0, 124923.0, 8659.48043117415, 8694.260987815853, 8731.471992401177, 8796.028628959968, 8982.011978682209, 64284.71430571269, 64429.355706444214, 65263.042108736816, 65992.3501912456, 66695.66652166708, 90339.09660903306, 99769.0, 100874.49562752139, 101480.0, 104042.0, 11372.0, 11769.588064417705, 11772.0, 11776.998955088571, 11797.115216358636, 12236.816447753114, 14995.17526536051, 15235.23823808783, 15260.694786103993, 15313.157776321963, 14133.505327313494, 14277.28613569338, 14304.0, 14455.638609034859, 14535.563933082025, 14399.640008999859, 14473.710525789636, 14483.203423811792, 14784.039037462531, 15099.54701358961, 12952.870471295166, 13974.650633734238, 14137.787933181216, 14283.857161428252, 14792.63018424548, 11648.109992868018, 11692.824607631062, 11899.226550274205, 11971.820422693492, 12101.576444824388, 9857.556409961713, 10703.464826758787, 10854.29447085937, 11942.4028798558, 12106.515739370327], "value": 8064.709572889375, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 143.0, 152.0, 155.0, 117.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 123.0, 120.0, 190.0, 134.0, 162.0, 125.0, 114.0, 192.0, 98.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 219.0, 209.0, 200.0, 211.0, 204.0, 201.0, 194.0, 198.0, 197.0], "value": 203.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 75.0, 141.0, 58.0, 59.0, 60.0, 62.0, 143.0, 70.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 123.0, 98.0, 98.0, 73.0, 112.0, 66.0, 71.0, 113.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 77.0, 80.0, 84.0, 129.0, 77.0, 94.0, 90.0, 128.0], "value": 91.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 93.0, 152.0, 156.0, 95.0, 96.0, 97.0, 99.0, 119.0, 110.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 115.0, 139.0, 87.0, 137.0, 144.0, 107.0, 94.0, 92.0], "value": 110.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 59.0, 55.0, 59.0, 53.0, 54.0, 54.0, 55.0, 58.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 73.0, 67.0, 90.0, 106.0, 70.0, 67.0, 74.0, 69.0], "value": 75.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 83.0, 85.0, 87.0, 84.0, 84.0, 85.0, 84.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 134.0, 132.0, 164.0, 151.0, 144.0, 150.0, 154.0, 214.0, 148.0], "value": 153.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 163.0, 164.0, 167.0, 161.0, 165.0, 167.0, 164.0, 166.0], "value": 165.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 64.0, 66.0, 69.0, 64.0, 68.0, 65.0, 67.0, 64.0], "value": 66.2, "unit": "score"}]}]} 20:07:05 INFO - Return code: 0 20:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:07:05 ERROR - # TBPL SUCCESS # 20:07:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:07:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:07:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:07:05 INFO - 2016-07-05 20:07:05.741 screenresolution[1675:10937] starting screenresolution argv=screenresolution get 20:07:05 INFO - 2016-07-05 20:07:05.743 screenresolution[1675:10937] Display 0: 1600x1200x32@60 20:07:05 INFO - 2016-07-05 20:07:05.749 screenresolution[1676:10940] starting screenresolution argv=screenresolution list 20:07:05 INFO - Available Modes on Display 0 20:07:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:07:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:07:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:07:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:07:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:07:05 INFO - Intel Iris: 20:07:05 INFO - Chipset Model: Intel Iris 20:07:05 INFO - Type: GPU 20:07:05 INFO - Bus: Built-In 20:07:05 INFO - VRAM (Dynamic, Max): 1536 MB 20:07:05 INFO - Vendor: Intel (0x8086) 20:07:05 INFO - Device ID: 0x0a2e 20:07:05 INFO - Revision ID: 0x0009 20:07:05 INFO - Displays: 20:07:05 INFO - Display: 20:07:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:07:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:07:05 INFO - Display Serial Number: 1600x1200 60 20:07:05 INFO - Main Display: Yes 20:07:05 INFO - Mirror: Off 20:07:05 INFO - Online: Yes 20:07:05 INFO - Rotation: Supported 20:07:05 INFO - Return code: 0 20:07:05 INFO - Running post-action listener: _resource_record_post_action 20:07:05 INFO - ##### 20:07:05 INFO - ##### Finished run-tests step (success) 20:07:05 INFO - ##### 20:07:05 INFO - Running post-run listener: _resource_record_post_run 20:07:06 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32521728; Write bytes: 706752000; Read time: 321; Write time: 1930 20:07:06 INFO - TinderboxPrint: CPU usage
54.3% 20:07:06 INFO - TinderboxPrint: I/O read bytes / time
32,521,728 / 321 20:07:06 INFO - TinderboxPrint: I/O write bytes / time
706,752,000 / 1,930 20:07:06 INFO - TinderboxPrint: CPU idle
2,211.8 (45.7%) 20:07:06 INFO - TinderboxPrint: CPU system
978.9 (20.2%) 20:07:06 INFO - TinderboxPrint: CPU user
1,651.0 (34.1%) 20:07:06 INFO - TinderboxPrint: Swap in / out
435,433,472 / 0 20:07:06 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407060992; Write bytes: 401438720; Read time: 30889; Write time: 775 20:07:06 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29142528; Write bytes: 295499264; Read time: 290; Write time: 1100 20:07:06 INFO - Running post-run listener: _upload_blobber_files 20:07:06 INFO - Blob upload gear active. 20:07:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:07:06 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 20:07:06 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'] 20:07:06 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 20:07:06 INFO - (blobuploader) - INFO - Open directory for files ... 20:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:07 INFO - (blobuploader) - INFO - Done attempting. 20:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:08 INFO - (blobuploader) - INFO - Done attempting. 20:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:07:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:07:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:07:11 INFO - (blobuploader) - INFO - Done attempting. 20:07:11 INFO - (blobuploader) - INFO - Iteration through files over. 20:07:11 INFO - Return code: 0 20:07:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:07:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:07:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/50dcaaa4ee8355721456f0feb4234d92fb82ba79bad98b579c3850718dfdbdcbcb4f952ed486987314e9e7662ac4e9ba88645cbc5bf611d6e8e8adeb8afc8988", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7ec820c6b5f6ded035a3b0016ee3e5dd04c4c5bfe86219663a3eba4ff4b46ece723be5b1f801d4aaabc39a6ac4b4026f803b95a84490bd9f236f1ccb712e8541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7beb557cdb42156fb95cb6e27d4a0851ac7999690bb8784e3eea480a3e8bbaf4c95c263c4d6ec01768573ad95800da1073df006efad594b4477acf4515a547dd"} 20:07:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:07:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:07:11 INFO - Contents: 20:07:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/50dcaaa4ee8355721456f0feb4234d92fb82ba79bad98b579c3850718dfdbdcbcb4f952ed486987314e9e7662ac4e9ba88645cbc5bf611d6e8e8adeb8afc8988", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7ec820c6b5f6ded035a3b0016ee3e5dd04c4c5bfe86219663a3eba4ff4b46ece723be5b1f801d4aaabc39a6ac4b4026f803b95a84490bd9f236f1ccb712e8541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7beb557cdb42156fb95cb6e27d4a0851ac7999690bb8784e3eea480a3e8bbaf4c95c263c4d6ec01768573ad95800da1073df006efad594b4477acf4515a547dd"} 20:07:11 INFO - Running post-run listener: copy_logs_to_upload_dir 20:07:11 INFO - Copying logs to upload dir... 20:07:11 INFO - mkdir: /builds/slave/test/build/upload/logs 20:07:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1326.577540 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 6 secs) (at 2016-07-05 20:07:11.327871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 20:07:11.331137) ========= 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.Dp3W56IoYz/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.rRx33bI5NC/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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/50dcaaa4ee8355721456f0feb4234d92fb82ba79bad98b579c3850718dfdbdcbcb4f952ed486987314e9e7662ac4e9ba88645cbc5bf611d6e8e8adeb8afc8988", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7ec820c6b5f6ded035a3b0016ee3e5dd04c4c5bfe86219663a3eba4ff4b46ece723be5b1f801d4aaabc39a6ac4b4026f803b95a84490bd9f236f1ccb712e8541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7beb557cdb42156fb95cb6e27d4a0851ac7999690bb8784e3eea480a3e8bbaf4c95c263c4d6ec01768573ad95800da1073df006efad594b4477acf4515a547dd"} build_url:https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/BXO4VMBwTrGFUFUV03Fa6A/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/50dcaaa4ee8355721456f0feb4234d92fb82ba79bad98b579c3850718dfdbdcbcb4f952ed486987314e9e7662ac4e9ba88645cbc5bf611d6e8e8adeb8afc8988", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7ec820c6b5f6ded035a3b0016ee3e5dd04c4c5bfe86219663a3eba4ff4b46ece723be5b1f801d4aaabc39a6ac4b4026f803b95a84490bd9f236f1ccb712e8541", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/7beb557cdb42156fb95cb6e27d4a0851ac7999690bb8784e3eea480a3e8bbaf4c95c263c4d6ec01768573ad95800da1073df006efad594b4477acf4515a547dd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 20:07:11.364115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:07:11.364444) ========= 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.Dp3W56IoYz/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.rRx33bI5NC/Listeners TMPDIR=/var/folders/9j/83h02rbx6bn60ztt0ypr7lsm00000w/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.004474 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 20:07:11.413249) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 20:07:11.413598) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 20:07:11.413945) ========= ========= Total master_lag: 0.18 =========