builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0287 starttime: 1467993539.33 results: success (0) buildid: 20160708063125 builduid: 38bca994601143eb83b14003834f6b67 revision: abb40d3751b5d345a2eca3203c01f18ce7773afa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.334621) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.335116) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.335441) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.389590) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.389922) ========= 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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-08 08:58:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-07-08 08:58:59 (18.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130145 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.544562) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.544949) ========= 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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.026445 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 08:58:59.594835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-08 08:58:59.595196) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev abb40d3751b5d345a2eca3203c01f18ce7773afa --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 abb40d3751b5d345a2eca3203c01f18ce7773afa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wTyJWGwxf4/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.8qgOe0nZvT/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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-08 08:58:59,676 truncating revision to first 12 chars 2016-07-08 08:58:59,676 Setting DEBUG logging. 2016-07-08 08:58:59,676 attempt 1/10 2016-07-08 08:58:59,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/abb40d3751b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 08:59:01,447 unpacking tar archive at: autoland-abb40d3751b5/testing/mozharness/ program finished with exit code 0 elapsedTime=2.047673 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-08 08:59:01.665028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 08:59:01.665378) ========= script_repo_revision: abb40d3751b5d345a2eca3203c01f18ce7773afa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 08:59:01.665812) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 08:59:01.666104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 08:59:01.683162) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2016-07-08 08:59:01.683509) ========= /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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:59:01 INFO - MultiFileLogger online at 20160708 08:59:01 in /builds/slave/test 08:59:01 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 08:59:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:59:01 INFO - {'append_to_log': False, 08:59:01 INFO - 'base_work_dir': '/builds/slave/test', 08:59:01 INFO - 'blob_upload_branch': 'Autoland', 08:59:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:59:01 INFO - 'branch': 'Autoland', 08:59:01 INFO - 'buildbot_json_path': 'buildprops.json', 08:59:01 INFO - 'config_files': ('talos/mac_config.py',), 08:59:01 INFO - 'default_actions': ('clobber', 08:59:01 INFO - 'read-buildbot-config', 08:59:01 INFO - 'download-and-extract', 08:59:01 INFO - 'populate-webroot', 08:59:01 INFO - 'create-virtualenv', 08:59:01 INFO - 'install', 08:59:01 INFO - 'run-tests'), 08:59:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:59:01 INFO - 'download_minidump_stackwalk': True, 08:59:01 INFO - 'download_symbols': 'ondemand', 08:59:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:59:01 INFO - 'tooltool.py': '/tools/tooltool.py', 08:59:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:59:01 INFO - '/tools/misc-python/virtualenv.py')}, 08:59:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:59:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:59:01 INFO - 'installer_path': 'installer.exe', 08:59:01 INFO - 'log_level': 'info', 08:59:01 INFO - 'log_name': 'talos', 08:59:01 INFO - 'log_to_console': True, 08:59:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:59:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:59:01 INFO - 'opt_config_files': (), 08:59:01 INFO - 'pip_index': False, 08:59:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:01 INFO - 'cmd': ('bash', 08:59:01 INFO - '-c', 08:59:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:01 INFO - 'enabled': True, 08:59:01 INFO - 'halt_on_failure': False, 08:59:01 INFO - 'name': 'check_screen_resolution'},), 08:59:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:59:01 INFO - 'cmd': ('bash', 08:59:01 INFO - '-c', 08:59:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:59:01 INFO - 'enabled': True, 08:59:01 INFO - 'halt_on_failure': False, 08:59:01 INFO - 'name': 'check_screen_resolution'},), 08:59:01 INFO - 'run_cmd_checks_enabled': True, 08:59:01 INFO - 'sps_profile': False, 08:59:01 INFO - 'sps_profile_interval': 0, 08:59:01 INFO - 'suite': 'dromaeojs-e10s', 08:59:01 INFO - 'system_bits': '32', 08:59:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:59:01 INFO - 'title': 't-yosemite-r7-0287', 08:59:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:59:01 INFO - 'use_talos_json': True, 08:59:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:59:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:59:01 INFO - 'work_dir': 'build'} 08:59:01 INFO - ##### 08:59:01 INFO - ##### Running clobber step. 08:59:01 INFO - ##### 08:59:01 INFO - Running pre-action listener: _resource_record_pre_action 08:59:01 INFO - Running main action method: clobber 08:59:01 INFO - rmtree: /builds/slave/test/build 08:59:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:59:03 INFO - Running post-action listener: _resource_record_post_action 08:59:03 INFO - ##### 08:59:03 INFO - ##### Finished clobber step (success) 08:59:03 INFO - ##### 08:59:03 INFO - ##### 08:59:03 INFO - ##### Running read-buildbot-config step. 08:59:03 INFO - ##### 08:59:03 INFO - Running pre-action listener: _resource_record_pre_action 08:59:03 INFO - Running main action method: read_buildbot_config 08:59:03 INFO - Using buildbot properties: 08:59:03 INFO - { 08:59:03 INFO - "project": "", 08:59:03 INFO - "product": "firefox", 08:59:03 INFO - "script_repo_revision": "production", 08:59:03 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 08:59:03 INFO - "repository": "", 08:59:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 08:59:03 INFO - "buildid": "20160708063125", 08:59:03 INFO - "pgo_build": "False", 08:59:03 INFO - "basedir": "/builds/slave/test", 08:59:03 INFO - "buildnumber": 18, 08:59:03 INFO - "slavename": "t-yosemite-r7-0287", 08:59:03 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:59:03 INFO - "platform": "yosemite_r7", 08:59:03 INFO - "scheduler": "tests-autoland-macosx64-talos", 08:59:03 INFO - "branch": "autoland", 08:59:03 INFO - "repo_path": "integration/autoland", 08:59:03 INFO - "revision": "abb40d3751b5d345a2eca3203c01f18ce7773afa", 08:59:03 INFO - "stage_platform": "macosx64", 08:59:03 INFO - "builduid": "38bca994601143eb83b14003834f6b67", 08:59:03 INFO - "slavebuilddir": "test" 08:59:03 INFO - } 08:59:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 08:59:03 INFO - Running post-action listener: _resource_record_post_action 08:59:03 INFO - ##### 08:59:03 INFO - ##### Finished read-buildbot-config step (success) 08:59:03 INFO - ##### 08:59:03 INFO - ##### 08:59:03 INFO - ##### Running download-and-extract step. 08:59:03 INFO - ##### 08:59:03 INFO - Running pre-action listener: _resource_record_pre_action 08:59:03 INFO - Running main action method: download_and_extract 08:59:03 INFO - mkdir: /builds/slave/test/build/tests 08:59:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:59:03 INFO - https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:59:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:59:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 08:59:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 08:59:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 08:59:33 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 08:59:33 INFO - retry: attempt #1 caught exception: timed out 08:59:33 INFO - retry: Failed, sleeping 30 seconds before retrying 09:00:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:10 INFO - Downloaded 1199 bytes. 09:00:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 09:00:10 INFO - Using the following test package requirements: 09:00:10 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:00:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 09:00:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 09:00:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'jsshell-mac.zip'], 09:00:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 09:00:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 09:00:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 09:00:10 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 09:00:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 09:00:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 09:00:10 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 09:00:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:10 INFO - https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:00:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:00:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:00:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:11 INFO - Downloaded 18806525 bytes. 09:00:11 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'] 09:00:11 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 09:00:15 INFO - Return code: 0 09:00:15 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 09:00:15 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')]} 09:00:15 INFO - https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:00:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:00:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 09:00:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:27 INFO - Downloaded 18806525 bytes. 09:00:27 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'] 09:00:27 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 09:00:30 INFO - Return code: 0 09:00: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')]} 09:00:30 INFO - https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:00:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:00:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 09:00:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:31 INFO - Downloaded 14403333 bytes. 09:00:31 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'] 09:00:31 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 09:00:32 INFO - Return code: 0 09:00:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:32 INFO - https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:00:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:00:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:00:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 09:00:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/e8XAbVYlQEKamGr3HoN8fw/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 09:00:35 INFO - Downloaded 112503444 bytes. 09:00:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:00:35 INFO - mkdir: /builds/slave/test/properties 09:00:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:00:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:00:35 INFO - Contents: 09:00:35 INFO - build_url:https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 09:00:36 INFO - Running post-action listener: _resource_record_post_action 09:00:36 INFO - Running post-action listener: set_extra_try_arguments 09:00:36 INFO - ##### 09:00:36 INFO - ##### Finished download-and-extract step (success) 09:00:36 INFO - ##### 09:00:36 INFO - ##### 09:00:36 INFO - ##### Running populate-webroot step. 09:00:36 INFO - ##### 09:00:36 INFO - Running pre-action listener: _resource_record_pre_action 09:00:36 INFO - Running main action method: populate_webroot 09:00:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:00:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:00:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:00:36 INFO - '--tppagecycles', 09:00:36 INFO - '7'], 09:00:36 INFO - 'tests': ['tsvgm']}}, 09:00:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:00:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:00:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:00:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:00:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:00:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['damp', 'tps']}, 09:00:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'tests': ['damp', 'tps']}, 09:00:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['dromaeo_dom']}, 09:00:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:00:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['basic_compositor_video']}, 09:00:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:00:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['a11yr', 09:00:36 INFO - 'ts_paint', 09:00:36 INFO - 'tpaint', 09:00:36 INFO - 'sessionrestore', 09:00:36 INFO - 'sessionrestore_no_auto_restore', 09:00:36 INFO - 'tabpaint']}, 09:00:36 INFO - 'other-e10s': {'tests': ['a11yr', 09:00:36 INFO - 'ts_paint', 09:00:36 INFO - 'tpaint', 09:00:36 INFO - 'sessionrestore', 09:00:36 INFO - 'sessionrestore_no_auto_restore', 09:00:36 INFO - 'tabpaint']}, 09:00:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:00:36 INFO - 'ts_paint', 09:00:36 INFO - 'tpaint', 09:00:36 INFO - 'sessionrestore', 09:00:36 INFO - 'sessionrestore_no_auto_restore', 09:00:36 INFO - 'tabpaint']}, 09:00:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:00:36 INFO - 'ts_paint', 09:00:36 INFO - 'tpaint', 09:00:36 INFO - 'sessionrestore', 09:00:36 INFO - 'sessionrestore_no_auto_restore', 09:00:36 INFO - 'tabpaint']}, 09:00:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['a11yr', 09:00:36 INFO - 'ts_paint', 09:00:36 INFO - 'tpaint', 09:00:36 INFO - 'sessionrestore', 09:00:36 INFO - 'sessionrestore_no_auto_restore', 09:00:36 INFO - 'tabpaint']}, 09:00:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['a11yr', 09:00:36 INFO - 'ts_paint', 09:00:36 INFO - 'tpaint', 09:00:36 INFO - 'sessionrestore', 09:00:36 INFO - 'sessionrestore_no_auto_restore', 09:00:36 INFO - 'tabpaint']}, 09:00:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['tsvgx', 09:00:36 INFO - 'tsvgr_opacity', 09:00:36 INFO - 'tart', 09:00:36 INFO - 'tscrollx', 09:00:36 INFO - 'cart']}, 09:00:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:00:36 INFO - 'tsvgr_opacity', 09:00:36 INFO - 'tart', 09:00:36 INFO - 'tscrollx', 09:00:36 INFO - 'cart']}, 09:00:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'talos_options': ['--disable-e10s'], 09:00:36 INFO - 'tests': ['tp5o']}, 09:00:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'tests': ['tp5o']}, 09:00:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'talos_options': ['--disable-e10s', 09:00:36 INFO - '--xperf_path', 09:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:36 INFO - 'tests': ['tp5n']}, 09:00:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:00:36 INFO - 'talos_options': ['--xperf_path', 09:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:00:36 INFO - 'tests': ['tp5n']}}, 09:00:36 INFO - 'talos.zip': {'path': '', 09:00:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:00:36 INFO - Running post-action listener: _resource_record_post_action 09:00:36 INFO - ##### 09:00:36 INFO - ##### Finished populate-webroot step (success) 09:00:36 INFO - ##### 09:00:36 INFO - ##### 09:00:36 INFO - ##### Running create-virtualenv step. 09:00:36 INFO - ##### 09:00:36 INFO - Running pre-action listener: _resource_record_pre_action 09:00:36 INFO - Running main action method: create_virtualenv 09:00:36 INFO - Creating virtualenv /builds/slave/test/build/venv 09:00:36 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 09:00:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:00:36 INFO - Using real prefix '/tools/python27' 09:00:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:00:37 INFO - Installing distribute.............................................................................................................................................................................................done. 09:00:39 INFO - Installing pip.................done. 09:00:40 INFO - Return code: 0 09:00:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:00: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', 'pip>=1.5'] in /builds/slave/test/build 09:00: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 pip>=1.5 09:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:40 INFO - 'HOME': '/Users/cltbld', 09:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:40 INFO - 'LOGNAME': 'cltbld', 09:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:40 INFO - 'MOZ_NO_REMOTE': '1', 09:00:40 INFO - 'NO_EM_RESTART': '1', 09:00:40 INFO - 'PAGER': '/bin/cat', 09:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:40 INFO - 'PWD': '/builds/slave/test', 09:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:40 INFO - 'SHELL': '/bin/bash', 09:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:00:40 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:40 INFO - 'USER': 'cltbld', 09:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:40 INFO - 'XPC_FLAGS': '0x0', 09:00:40 INFO - 'XPC_SERVICE_NAME': '0', 09:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:40 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 09:00:40 INFO - Cleaning up... 09:00:40 INFO - Return code: 0 09:00:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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', '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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:00: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 psutil>=3.1.1 09:00:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:00:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:40 INFO - 'HOME': '/Users/cltbld', 09:00:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:40 INFO - 'LOGNAME': 'cltbld', 09:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:40 INFO - 'MOZ_NO_REMOTE': '1', 09:00:40 INFO - 'NO_EM_RESTART': '1', 09:00:40 INFO - 'PAGER': '/bin/cat', 09:00:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:40 INFO - 'PWD': '/builds/slave/test', 09:00:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:40 INFO - 'SHELL': '/bin/bash', 09:00:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:00:40 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:00:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:40 INFO - 'USER': 'cltbld', 09:00:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:40 INFO - 'XPC_FLAGS': '0x0', 09:00:40 INFO - 'XPC_SERVICE_NAME': '0', 09:00:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:40 INFO - Downloading/unpacking psutil>=3.1.1 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:00:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:43 INFO - Installing collected packages: psutil 09:00:43 INFO - Running setup.py install for psutil 09:00:43 INFO - building 'psutil._psutil_osx' extension 09:00:43 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 09:00:44 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 09:00:44 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 09:00:44 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 09:00:44 INFO - building 'psutil._psutil_posix' extension 09:00:44 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 09:00:44 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:00:44 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:00:44 INFO - ^ 09:00:44 INFO - 1 warning generated. 09:00:44 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 09:00:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:00:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:00:44 INFO - Successfully installed psutil 09:00:44 INFO - Cleaning up... 09:00:45 INFO - Return code: 0 09:00:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:00: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')]} 09:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00: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')]} 09:00:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:45 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:00:45 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 09:00:45 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 09:00:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:00:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:45 INFO - 'HOME': '/Users/cltbld', 09:00:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:45 INFO - 'LOGNAME': 'cltbld', 09:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:45 INFO - 'MOZ_NO_REMOTE': '1', 09:00:45 INFO - 'NO_EM_RESTART': '1', 09:00:45 INFO - 'PAGER': '/bin/cat', 09:00:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:45 INFO - 'PWD': '/builds/slave/test', 09:00:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:45 INFO - 'SHELL': '/bin/bash', 09:00:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:00:45 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:00:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:45 INFO - 'USER': 'cltbld', 09:00:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:45 INFO - 'XPC_FLAGS': '0x0', 09:00:45 INFO - 'XPC_SERVICE_NAME': '0', 09:00:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:00:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:00:47 INFO - Installing collected packages: mozsystemmonitor 09:00:47 INFO - Running setup.py install for mozsystemmonitor 09:00:47 INFO - Successfully installed mozsystemmonitor 09:00:47 INFO - Cleaning up... 09:00:48 INFO - Return code: 0 09:00:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:48 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:00:48 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 09:00:48 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 09:00:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:00:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:48 INFO - 'HOME': '/Users/cltbld', 09:00:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:48 INFO - 'LOGNAME': 'cltbld', 09:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:48 INFO - 'MOZ_NO_REMOTE': '1', 09:00:48 INFO - 'NO_EM_RESTART': '1', 09:00:48 INFO - 'PAGER': '/bin/cat', 09:00:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:48 INFO - 'PWD': '/builds/slave/test', 09:00:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:48 INFO - 'SHELL': '/bin/bash', 09:00:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:00:48 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:00:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:48 INFO - 'USER': 'cltbld', 09:00:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:48 INFO - 'XPC_FLAGS': '0x0', 09:00:48 INFO - 'XPC_SERVICE_NAME': '0', 09:00:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:48 INFO - Downloading/unpacking jsonschema==2.5.1 09:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:00:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:00:50 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 09:00:50 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 09:00:50 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 09:00:50 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 09:00:50 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 09:00:50 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 09:00:51 INFO - Downloading functools32-3.2.3-2.tar.gz 09:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:00:51 INFO - warning: no files found matching '*.txt' 09:00:51 INFO - no previously-included directories found matching 'build' 09:00:51 INFO - no previously-included directories found matching 'dist' 09:00:51 INFO - no previously-included directories found matching '.git*' 09:00:51 INFO - Installing collected packages: jsonschema, functools32 09:00:51 INFO - Running setup.py install for functools32 09:00:51 INFO - warning: no files found matching '*.txt' 09:00:51 INFO - no previously-included directories found matching 'build' 09:00:51 INFO - no previously-included directories found matching 'dist' 09:00:51 INFO - no previously-included directories found matching '.git*' 09:00:51 INFO - Successfully installed jsonschema functools32 09:00:51 INFO - Cleaning up... 09:00:51 INFO - Return code: 0 09:00:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:51 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:00:51 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 09:00:51 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 09:00:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:00:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:51 INFO - 'HOME': '/Users/cltbld', 09:00:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:51 INFO - 'LOGNAME': 'cltbld', 09:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:51 INFO - 'MOZ_NO_REMOTE': '1', 09:00:51 INFO - 'NO_EM_RESTART': '1', 09:00:51 INFO - 'PAGER': '/bin/cat', 09:00:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:51 INFO - 'PWD': '/builds/slave/test', 09:00:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:51 INFO - 'SHELL': '/bin/bash', 09:00:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:00:51 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:00:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:51 INFO - 'USER': 'cltbld', 09:00:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:51 INFO - 'XPC_FLAGS': '0x0', 09:00:51 INFO - 'XPC_SERVICE_NAME': '0', 09:00:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:51 INFO - Downloading/unpacking blobuploader==1.2.4 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00: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 09:00:54 INFO - Downloading blobuploader-1.2.4.tar.gz 09:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:00:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:00:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:00:55 INFO - Downloading docopt-0.6.1.tar.gz 09:00:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:00:55 INFO - Installing collected packages: blobuploader, requests, docopt 09:00:55 INFO - Running setup.py install for blobuploader 09:00:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:00:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:00:55 INFO - Running setup.py install for requests 09:00:56 INFO - Running setup.py install for docopt 09:00:56 INFO - Successfully installed blobuploader requests docopt 09:00:56 INFO - Cleaning up... 09:00:56 INFO - Return code: 0 09:00:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:00:56 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:00:56 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 09:00:56 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 09:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:00:56 INFO - 'HOME': '/Users/cltbld', 09:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:00:56 INFO - 'LOGNAME': 'cltbld', 09:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:00:56 INFO - 'MOZ_NO_REMOTE': '1', 09:00:56 INFO - 'NO_EM_RESTART': '1', 09:00:56 INFO - 'PAGER': '/bin/cat', 09:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:00:56 INFO - 'PWD': '/builds/slave/test', 09:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:00:56 INFO - 'SHELL': '/bin/bash', 09:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:00:56 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:00:56 INFO - 'USER': 'cltbld', 09:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:00:56 INFO - 'XPC_FLAGS': '0x0', 09:00:56 INFO - 'XPC_SERVICE_NAME': '0', 09:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:00:56 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-MenbtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:00:56 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-AG1Nmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:00:56 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-zh6RMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:00:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-ManuOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-nyxSdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-nDvP1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-H4dGIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-pHxRAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-PWbiIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-6T_DWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-oN5SIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-pOZSCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:00:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:00:57 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-yxJhP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:00:58 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-hNZVZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:58 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-7veAhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:00:58 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-EF6pgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:00:58 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-kgY4n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:00:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:00:58 INFO - Running setup.py install for manifestparser 09:00:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:00:58 INFO - Running setup.py install for mozcrash 09:00:58 INFO - Running setup.py install for mozdebug 09:00:58 INFO - Running setup.py install for mozdevice 09:00:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Running setup.py install for mozfile 09:00:59 INFO - Running setup.py install for mozhttpd 09:00:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Running setup.py install for mozinfo 09:00:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Running setup.py install for mozInstall 09:00:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:00:59 INFO - Running setup.py install for mozleak 09:00:59 INFO - Running setup.py install for mozlog 09:01:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:01:00 INFO - Running setup.py install for moznetwork 09:01:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:01:00 INFO - Running setup.py install for mozprocess 09:01:00 INFO - Running setup.py install for mozprofile 09:01:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:01:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:01:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:01:00 INFO - Running setup.py install for mozrunner 09:01:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:01:00 INFO - Running setup.py install for mozscreenshot 09:01:00 INFO - Running setup.py install for moztest 09:01:00 INFO - Running setup.py install for mozversion 09:01:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:01:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:01:01 INFO - Cleaning up... 09:01:01 INFO - Return code: 0 09:01:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:01 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:01:01 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 09:01:01 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 09:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:01 INFO - 'HOME': '/Users/cltbld', 09:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:01 INFO - 'LOGNAME': 'cltbld', 09:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:01 INFO - 'MOZ_NO_REMOTE': '1', 09:01:01 INFO - 'NO_EM_RESTART': '1', 09:01:01 INFO - 'PAGER': '/bin/cat', 09:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:01 INFO - 'PWD': '/builds/slave/test', 09:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:01 INFO - 'SHELL': '/bin/bash', 09:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:01:01 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:01 INFO - 'USER': 'cltbld', 09:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:01 INFO - 'XPC_FLAGS': '0x0', 09:01:01 INFO - 'XPC_SERVICE_NAME': '0', 09:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:01:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Ay0IiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:01:01 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)) 09:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:01:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-r3RBid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:01:01 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)) 09:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:01:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-jwtWhz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:01:01 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)) 09:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:01:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Ja4Iw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:01:01 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)) 09:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:01:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-jQEvlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:01:01 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)) 09:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:01:01 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-tdewQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-a2oiAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-pUJoNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-VscF_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-lCo0hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-cEkn4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-7yJL89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-wvsGsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:01:02 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)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-NCDCSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:02 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-Skabwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:01:03 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)) 09:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:01:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-sydmE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:01:03 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)) 09:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:01:03 INFO - Running setup.py (path:/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/pip-ZFD6wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 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)) 09:01:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:01:03 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 09:01:03 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 09:01:03 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 09:01:03 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 09:01:03 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 09:01:03 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 09:01:05 INFO - Downloading blessings-1.6.tar.gz 09:01:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:01:05 INFO - Installing collected packages: blessings 09:01:05 INFO - Running setup.py install for blessings 09:01:05 INFO - Successfully installed blessings 09:01:05 INFO - Cleaning up... 09:01:05 INFO - Return code: 0 09:01:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:06 INFO - Reading from file tmpfile_stdout 09:01:06 INFO - Current package versions: 09:01:06 INFO - blessings == 1.6 09:01:06 INFO - blobuploader == 1.2.4 09:01:06 INFO - docopt == 0.6.1 09:01:06 INFO - functools32 == 3.2.3-2 09:01:06 INFO - jsonschema == 2.5.1 09:01:06 INFO - manifestparser == 1.1 09:01:06 INFO - mozInstall == 1.12 09:01:06 INFO - mozcrash == 0.17 09:01:06 INFO - mozdebug == 0.1 09:01:06 INFO - mozdevice == 0.48 09:01:06 INFO - mozfile == 1.2 09:01:06 INFO - mozhttpd == 0.7 09:01:06 INFO - mozinfo == 0.9 09:01:06 INFO - mozleak == 0.1 09:01:06 INFO - mozlog == 3.2 09:01:06 INFO - moznetwork == 0.27 09:01:06 INFO - mozprocess == 0.23 09:01:06 INFO - mozprofile == 0.28 09:01:06 INFO - mozrunner == 6.12 09:01:06 INFO - mozscreenshot == 0.1 09:01:06 INFO - mozsystemmonitor == 0.3 09:01:06 INFO - moztest == 0.7 09:01:06 INFO - mozversion == 1.4 09:01:06 INFO - psutil == 3.1.1 09:01:06 INFO - requests == 1.2.3 09:01:06 INFO - wsgiref == 0.1.2 09:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:06 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:01:06 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 09:01:06 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 09:01:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:01:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:06 INFO - 'HOME': '/Users/cltbld', 09:01:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:06 INFO - 'LOGNAME': 'cltbld', 09:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:06 INFO - 'MOZ_NO_REMOTE': '1', 09:01:06 INFO - 'NO_EM_RESTART': '1', 09:01:06 INFO - 'PAGER': '/bin/cat', 09:01:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:06 INFO - 'PWD': '/builds/slave/test', 09:01:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:06 INFO - 'SHELL': '/bin/bash', 09:01:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:01:06 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:01:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:06 INFO - 'USER': 'cltbld', 09:01:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:06 INFO - 'XPC_FLAGS': '0x0', 09:01:06 INFO - 'XPC_SERVICE_NAME': '0', 09:01:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 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)) 09:01:06 INFO - Cleaning up... 09:01:06 INFO - Return code: 0 09:01:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:01: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')]} 09:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01: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')]} 09:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:01:06 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 0x102ab3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102b48618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3c04c3310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, '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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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 09:01:06 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 09:01:06 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 09:01:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:01:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:06 INFO - 'HOME': '/Users/cltbld', 09:01:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:06 INFO - 'LOGNAME': 'cltbld', 09:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:06 INFO - 'MOZ_NO_REMOTE': '1', 09:01:06 INFO - 'NO_EM_RESTART': '1', 09:01:06 INFO - 'PAGER': '/bin/cat', 09:01:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:06 INFO - 'PWD': '/builds/slave/test', 09:01:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:06 INFO - 'SHELL': '/bin/bash', 09:01:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:01:06 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:01:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:06 INFO - 'USER': 'cltbld', 09:01:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:06 INFO - 'XPC_FLAGS': '0x0', 09:01:06 INFO - 'XPC_SERVICE_NAME': '0', 09:01:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:01:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:01:06 INFO - Cleaning up... 09:01:06 INFO - Return code: 0 09:01:06 INFO - Running post-action listener: _resource_record_post_action 09:01:06 INFO - Running post-action listener: _start_resource_monitoring 09:01:06 INFO - Starting resource monitoring. 09:01:06 INFO - ##### 09:01:06 INFO - ##### Finished create-virtualenv step (success) 09:01:06 INFO - ##### 09:01:06 INFO - ##### 09:01:06 INFO - ##### Running install step. 09:01:06 INFO - ##### 09:01:06 INFO - Running pre-action listener: _resource_record_pre_action 09:01:06 INFO - Running main action method: install 09:01:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:01:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:01:07 INFO - Reading from file tmpfile_stdout 09:01:07 INFO - Detecting whether we're running mozinstall >=1.0... 09:01:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:01:07 INFO - Reading from file tmpfile_stdout 09:01:07 INFO - Output received: 09:01:07 INFO - Usage: mozinstall [options] installer 09:01:07 INFO - Options: 09:01:07 INFO - -h, --help show this help message and exit 09:01:07 INFO - -d DEST, --destination=DEST 09:01:07 INFO - Directory to install application into. [default: 09:01:07 INFO - "/builds/slave/test"] 09:01:07 INFO - --app=APP Application being installed. [default: firefox] 09:01:07 INFO - mkdir: /builds/slave/test/build/application 09:01:07 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'] 09:01:07 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 09:01:41 INFO - Reading from file tmpfile_stdout 09:01:41 INFO - Output received: 09:01:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:01:41 INFO - Running post-action listener: _resource_record_post_action 09:01:41 INFO - ##### 09:01:41 INFO - ##### Finished install step (success) 09:01:41 INFO - ##### 09:01:41 INFO - ##### 09:01:41 INFO - ##### Running run-tests step. 09:01:41 INFO - ##### 09:01:41 INFO - Running pre-action listener: _resource_record_pre_action 09:01:41 INFO - Running main action method: run_tests 09:01:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:41 INFO - 2016-07-08 09:01:41.978 screenresolution[1644:7864] starting screenresolution argv=screenresolution get 09:01:41 INFO - 2016-07-08 09:01:41.980 screenresolution[1644:7864] Display 0: 1600x1200x32@60 09:01:41 INFO - 2016-07-08 09:01:41.986 screenresolution[1645:7866] starting screenresolution argv=screenresolution list 09:01:41 INFO - Available Modes on Display 0 09:01:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:42 INFO - Intel Iris: 09:01:42 INFO - Chipset Model: Intel Iris 09:01:42 INFO - Type: GPU 09:01:42 INFO - Bus: Built-In 09:01:42 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:42 INFO - Vendor: Intel (0x8086) 09:01:42 INFO - Device ID: 0x0a2e 09:01:42 INFO - Revision ID: 0x0009 09:01:42 INFO - Displays: 09:01:42 INFO - Display: 09:01:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:42 INFO - Display Serial Number: 1600x1200 60 09:01:42 INFO - Main Display: Yes 09:01:42 INFO - Mirror: Off 09:01:42 INFO - Online: Yes 09:01:42 INFO - Rotation: Supported 09:01:42 INFO - Return code: 0 09:01:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:01:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:01:42 INFO - Python 2.7.3 09:01:42 INFO - Return code: 0 09:01:42 INFO - grabbing minidump binary from tooltool 09:01:42 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')]} 09:01:42 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 0x102a17d30>, '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 0x10277cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102a0fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:01:42 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 09:01:42 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 09:01:42 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 09:01:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:01:42 INFO - Return code: 0 09:01:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:01:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:01:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:01:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:01:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:01:42 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/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--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 09:01:42 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/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0287 --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 09:01:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wTyJWGwxf4/Render', 09:01:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:01:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:01:42 INFO - 'HOME': '/Users/cltbld', 09:01:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:01:42 INFO - 'LOGNAME': 'cltbld', 09:01:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:01:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:01:42 INFO - 'MOZ_NO_REMOTE': '1', 09:01:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:01:42 INFO - 'NO_EM_RESTART': '1', 09:01:42 INFO - 'PAGER': '/bin/cat', 09:01:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:01:42 INFO - 'PWD': '/builds/slave/test', 09:01:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:01:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:01:42 INFO - 'SHELL': '/bin/bash', 09:01:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8qgOe0nZvT/Listeners', 09:01:42 INFO - 'TMPDIR': '/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/', 09:01:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:01:42 INFO - 'USER': 'cltbld', 09:01:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:01:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:01:42 INFO - 'XPC_FLAGS': '0x0', 09:01:42 INFO - 'XPC_SERVICE_NAME': '0', 09:01:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:01:42 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/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0287', '--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 09:01:42 INFO - mozversion application_buildid: 20160708063125 09:01:42 INFO - mozversion application_changeset: abb40d3751b5d345a2eca3203c01f18ce7773afa 09:01:42 INFO - mozversion application_display_name: Nightly 09:01:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:01:42 INFO - mozversion application_name: Firefox 09:01:42 INFO - mozversion application_remotingname: firefox 09:01:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 09:01:42 INFO - mozversion application_vendor: Mozilla 09:01:42 INFO - mozversion application_version: 50.0a1 09:01:42 INFO - mozversion platform_buildid: 20160708063125 09:01:42 INFO - mozversion platform_changeset: abb40d3751b5d345a2eca3203c01f18ce7773afa 09:01:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 09:01:42 INFO - mozversion platform_version: 50.0a1 09:01:42 INFO - using testdate: 1467993702 09:01:42 INFO - actual date: 1467993702 09:01:42 INFO - starting webserver on 'localhost:49282' 09:01:42 INFO - SUITE-START | Running 2 tests 09:01:42 INFO - TEST-START | dromaeo_css 09:01:42 INFO - operating with platform_type : mac_ 09:01:42 INFO - Initialising browser for dromaeo_css test... 09:01:42 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpEQQiKy/profile http://localhost:49282/getInfo.html) 09:01:45 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 09:01:45 INFO - PROCESS | 1655 | colorDepth:24 09:01:45 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 09:01:45 INFO - PROCESS | 1655 | __metrics 09:01:45 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 09:01:46 INFO - TEST-INFO | 1655: exit 0 09:01:46 INFO - Browser initialized. 09:01:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:01:46 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmpEQQiKy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:58 INFO - PROCESS | 1658 | RSS: Main: 254066688 09:01:58 INFO - PROCESS | 1658 | 09:02:47 INFO - PROCESS | 1658 | 1467993767932 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] 09:04:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49282/tests/dromaeo/cssquery-ext.html) 09:04:59 INFO - PROCESS | 1658 | RSS: Main: 266739712 09:04:59 INFO - PROCESS | 1658 | 09:08:02 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-ext.html (next: http://localhost:49282/tests/dromaeo/cssquery-jquery.html) 09:08:02 INFO - PROCESS | 1658 | RSS: Main: 275292160 09:08:02 INFO - PROCESS | 1658 | 09:11:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49282/tests/dromaeo/cssquery-mootools.html) 09:11:05 INFO - PROCESS | 1658 | RSS: Main: 279875584 09:11:05 INFO - PROCESS | 1658 | 09:14:06 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49282/tests/dromaeo/cssquery-prototype.html) 09:14:07 INFO - PROCESS | 1658 | RSS: Main: 279273472 09:14:07 INFO - PROCESS | 1658 | 09:17:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49282/tests/dromaeo/cssquery-yui.html) 09:17:10 INFO - PROCESS | 1658 | RSS: Main: 282427392 09:17:10 INFO - PROCESS | 1658 | 09:20:13 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49282/tests/dromaeo/cssquery-yui.html (next: http://localhost:49282/tests/dromaeo/cssquery-dojo.html) 09:20:14 INFO - PROCESS | 1658 | RSS: Main: 282763264 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | __start_tp_report 09:20:14 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 09:20:14 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 09:20:14 INFO - PROCESS | 1658 | |i|pagename|runs| 09:20:14 INFO - PROCESS | 1658 | |0;dojo.html;3376.054704682689;3377.864885404584;3398.3033478136986;3402.234497238121;3416.385050690876;5641.971790141049;5727.856803579913;5749.942500574993;5750.3962083981205;5822.184894114822;4372.60646541812;4894.800773810422;5526.972365138179;5738.196652468658;5773.913391299134;5137.3064636274;5185.896282074356;5261.053010458116;5321.095413779667;5351.625386222966;352.26161207603025;5232.8691782705355;5248.947510524884;5258.395284542288;5312;3840.7503512271614;5162.845114646567;5205.37535495741;5209.479052094798;5288.867778305535;5132.332796736438;5219.530242278213;5232.450592687751;5241.711705856176;5266.473352664703;4306.418633484503;5121.359830021247;5193.195054766479;5216.66091704038;5230.137027390476;3988.940165897514;5685.374608793029;5727.770889164429;5759.280089988752;5760.7695692172265;4789.592884604813;6023.066424704134;6100.542459315569;6115.663638499881;6193.38066193377;6162.260528736536;6182.1345011698395;6185;6192.411720886508;6195.256569211723;5737.2254745609225;5737.512311453532;5749.626274292157;5750.482456578844;5800.245968024172;5231.215317702375;5477.643953143033;6123.618175568305;6174.44430001302;6188.133661287423;5003.674761140514;5906.114082887515;6096.69516524172;6118.357572454917;6128.816135515942;6111.052786818051;6178.938210617926;6179.443850053517;6181.629102253879;6196.907046394308;6011.729472173763;6075.179850720185;6077.96674565325;6125.816225513242;6136.110264011693;6020.096985452217;6037.215162028908;6060.363661815534;6072.240969878765;6102.969485152635;4857.854264372075;4865.659403841768;4871.269309603588;4891.461939186686;4915.459299477055;4296.484421869396;4349.978250108729;4373.343998400265;4377.430933978562;4468.776561171929;4786.2820576913045;5801.854953626109;5869.559783016291;5888.499477544457;5919.230500034968;6190.226221722285;6200.472959798378;6202.472789812826;6210.037444196157;6227.688615569204;5646.2377579027125;5769.423057694197;5855.824325270249;5872.324682661549;5889.469947704727;5387.757550910218;5399.190121481731;5401.972990135103;5422.078246698071;5434.157705555645;6239.937600623935;6260.154879091265;6266.342034086447;6271.623702577769;6292.182016337847;6111.348653136637;6112.083187521907;6129.325774164928;6152.538559607958;6184.81445556634;6146.723397447036;6183.659898705434;6211.378862113753;6222.564420490522;6252.624842509464;4423.518121429229;5980.3421623622235;6072.180255665606;6078.149059131813;6079.635221886701;6049.879002420015;6133.2428548619655;6166.660833654192;6187.597806142587;6211.81364559064;5152.690838549699;6014.488768454556;6050.969745151246;6069.362716914837;6148.354422785722;5439.48324909133;5805.419458054161;6093.908591371044;6094.146819445193;6099.817005489843;5193.480651934777;5374.623776335619;5422.755975981011;5428.4842939920645;5800.274965629296;6009.308929473166;6019.969900150471;6055.364186760326;6063.818085457443;6111.724972376165;5055.418626857959;5924.7037648118285;5938.079597662369;5951.494122999594;5956.047032474783 09:20:14 INFO - PROCESS | 1658 | |1;ext.html;495.2126119470043;511.442527644867;514.9021685879683;529.9470052994699;541.8807862270302;33137.00588982328;37538.24923501528;38723.22553548928;38726.61273387265;38737.612623873756;39374;39539.20921581567;40284.79857600708;40316.79841600795;40383.39424908629;9124.31567632427;9337.906620933805;9347.252219822432;9353.298502612332;9370.85943710845;9497.430154190735;9553.044695530427;9591.952040239825;9593.088656577649;9644.758881027996;9537.189338906166;9596.856047159297;9636.710898673016;9655.13103820656;9683.031696830296;9544.61821527138;9608.501789534701;9614.807703845954;9629;9642.951785241028;8101;9482.19401350886;9574.952125239399;9586.233101351874;9594.616215351378;38182.618173818184;38299;38485.42271865924;38541.80729096365;38770;2709.972900270992;3319.867205311785;3348.983255083709;3560.8219589020705;3642.3079614873354;30645.387092258254;30647;31183;31393.52909706356;31427.37145257082;3097.814131152138;3103.5499852521257;3117.579126817873;3120;3224.871005159791;425047.87476062734;433676;462743.6862815698;467532.9999999966;468371;32958.67041329556;32976.505352419736;33015;33738.49392259069;34438.65561344405;34474.31051378958;34741.957741267805;34836.129096772784;34916.82541587276;35023.64976350255;12933.935330323477;15042.924785376003;15151.242437878062;15163.620909477351;15165.09009459436;10875.347479151276;12802.295873726847;12955.222686638832;12957.611271661865;13160.934195329153;7375.631218439056;7586.810329741801;7598.316151546387;7606.3914886808925;7632.1986191450205;2934.618499595039;2963.9110826675233;3000.354923691417;3193.499055443938;3197.8401079946375;947.303731757158;1007.8437842134481;1041.4844651897208;1078.6332646900091;1131.9773604527863;29707.85146074299;29894.85052574723;30091.548626770615;30130.84934575313;30960.690393096233;938.5166639180827;998.9600415983425;1026.235454586338;1068.7755571330108;1103.0844399148687;13411;14933.626659333604;15132.010903085875;15243.923780381027;15559.688806223812;684221;689561;694426.5278673575;699247;702180;55904.44095559074;56125.15812262819;56841.43158568444;56888.43111568914;57311.426885731446;1394.8884089272833;1417.4684493315008;1423.814904062486;1433.9426422942965;1444.2562080528537;28863.989760359127;28896.98860539871;29060.854695726386;29669.703302966693;29694.406111877208;49075;49640;50239.49760502348;50315.49684503255;50370;623579;625655;642860;644931;648896.0441582473;25572.8721356392;25632.102876399236;25788.742112578635;25908.8704556476;26133.869330653226;45407;45589.54410455853;45720.31419528643;46244.02606084237;46940.53059469361;37983;38117.80941095277;38783.806080969414;39173.21653566856;39249.8037509822;38067.857964261115;38121.61878381292;38205.044873878374;38592;38771.806140969114;33164.33671326512;36572.81713591415;36884.07789805276;37314;39024.80487597544;31137.844310778302;33079.50380744242;33509.83245083759;34117.829410852784;34163.829180853936;24974.37564060913;25012.985456288345;25019.624705629067;25228.621570676823;25514.97940082376 09:20:14 INFO - PROCESS | 1658 | |2;jquery.html;316.3988421998203;325.27463755824505;381.3288612042804;382.48364707644686;393.6221227621483;18083.367082152126;20252.493687657818;20283.898580507095;21392.679109813365;21697.34907952762;17537.123143842822;19916.800831991677;20755;20776.792232077674;21055.894720526416;5244.711540865251;5859.736311865966;5935.436133567304;6050.848728781772;6051.818445446644;5828.679422631753;5951.970240148793;6000.639961602296;6024.7288872000645;6039.667818269993;5839.532837373;5841.094630332284;5948.702564871739;5968.1346204800275;5978.402159784008;5780.393058728836;5931.258592675916;5933;5933.970330148343;5934.258217722785;4493.281075028012;5089.694618322913;5172.689638621695;5426.267453893753;5436.320459942507;11080.113590912708;12957.48170073196;13237.602871913761;13286.3356832158;13458.865411345958;2189.321310393767;2205.0848897707433;2305.7233132024267;2311.4914718762016;2798.3703666674837;9676.516174191262;9753.756156096084;9966.053224943618;9968.750781230454;10180.796384072277;1783.3312507809571;1811.4565630310985;1825.196913358118;1862.5995410986702;1900.6008738165;130011;132768.0084798729;133189.33405333105;135684.32157839247;137639;11050.50818139541;11219.66341009771;11224.326540407601;11490.942545287387;11637.767244655059;13274.535391261259;14372.209528476034;14397.856021439651;14423.711525769426;14526;6729.92321228601;8290.792730181794;8599.828003440021;8698.739037828875;8755.912440875638;8666.133386661284;8732.65069397217;8740;8845.292376609856;8865.468071915706;4447.466304043535;4471.709338892962;4535.115652447807;4540.79566419512;4563.315502674559;1901.7622797150357;1935.332310352926;1948.5518330783998;1953.990230048869;1956.3935180094215;820.8016296207604;890.3544929925752;906.6735975048977;923.9769005774909;980.8332583460686;20207.989600519915;21030;21051.263205787724;21168.259110931045;21326.466838329165;751.5040073551539;890.5057692980458;926.5876684875166;960.7550074730899;1026.1329176845554;9647.179989700813;10228.619136416637;10548.419836909045;11079.50142243601;11102.777944441066;624376.8781156156;625069;635651;639837;645177;112862.43568782268;132318;137427.44149071697;140605;142008;931.8136372725482;969.6606187834202;987.3335498538457;988.5847943863595;997.0677416615488;15907.761383579487;18719;19102;19148.617027659646;19563.706544402132;57923.841523168456;60435.395646042976;60577.69711151416;61896.38103619086;62294;90438;90778.54610726904;90880;91303.6304455447;91809;7120.2167761547225;7589.1651918290045;7627.580483073484;7993.400494962785;8398.832023359377;9468.242540596873;13384.464621415034;13667.589972300846;13753.786562049878;13956.790648140082;10069;11535.480903359201;11622.593209237637;11803;11859.881401185878;11564.94217528907;11604.361760103275;11611.825822612836;11678.299302041905;11692.298462092302;5926.1999630049395;11834.467448964646;11892.940535297614;11964.76070478603;11997.280163190237;7516.736914207976;7558.735444259424;7583.734569290048;7626.656800443882;7814.843703126019;11780.82328765052;11803.468843901874;11815.172937894265;11839.822402663794;11856.585019524275 09:20:14 INFO - PROCESS | 1658 | |3;mootools.html;1502.3014298351268;1549.3028137338201;1788.1595650044474;1911.2259534888376;1926.4509614759797;8160.877586836202;8701.129887011295;8771.122887711226;9187.081291870809;9196.586153623079;8864.15790499903;8887.24458421035;9035.412698174614;9053.683121090764;9093.13615206556;2056.4139220322213;2326.581215381231;2369.4668699542553;2385.725641551218;2391.868447235401;2357.0807385119815;2361.9409514762183;2389;2392.988035059831;2404.95190096198;2368.857868527894;2376.6791483149814;2386.9761302387014;2394.425337918896;2402.531506356261;2359.622460406344;2366.751491093436;2379.916702915398;2386.606209975352;2387.8925448354867;2337.8714170720605;2338.286822519131;2357.622780355152;2383.761623837602;2386.6300723387903;9127.634894604207;9211.30915181364;9229.030951750037;9242;9243.26053915685;5345.9842629900195;5508.118701007819;5528.530074943635;5529.585281103933;5541.33503979521;3498.1254686328416;3609.187932715144;3673.522442082539;3674.963250367489;3675.9448608270895;906.3700727994046;969.3602222533094;1075.9515821788038;1082.5290998415715;1103.332483847277;10635.840462393071;11647.41762911851;11809.996150327232;11925.522979080826;11943.701407464796;4484.506704262529;4511.548845115462;4630.791614377361;4664.39362882823;4688.5545873142;8125.3499720022255;9356.111169438893;9387.202087822476;9400.200982916393;9410.670626528039;5186.611004174627;5192.247124166975;5280;5334.5732341412595;5349.786008559614;4460.553944605514;4850.272459131159;4864.586510146677;4998.500149984972;5005.774740136702;3788.677962373174;3844.058205739556;3882.611738826095;3918.647321741057;3960.3663413853646;1171.6719318590808;1175.1362748379934;1177.7055736065984;1187.5724739093919;1187.9109066820024;928.967486137982;936.9344145909857;937.6671281695036;944.5230158769778;992.0674565908023;5079.4412614612365;6095.4818840398175;6144.354842741537;6180.134781130645;6220.346863579259;436.32805479561756;440.2999231222372;451.2464184811373;452.5429316390404;459.65755512143;4111.1366613011605;4150.896227594334;4153.293940030142;4164.500259968823;4195.056112374752;10104.646337378303;10923.672289831318;10977.3962432067;11055.949684779933;11062.834057489144;10803.459827008619;10806.567737290421;11045.889541104487;11080.722981925355;11099.556017759362;7946.284834364935;8314.41799074059;8359.122292159236;8383.916160838435;8408.41141120128;5250.65870718402;6143.262808463013;6181.474574661204;6245.156903817927;6258.780942666985;9223.58493867791;10354.482275886025;10372.325798823053;10392.116670082825;10401;10098;10223.795524089328;10512.211584131373;10633.255672102878;10670.62652807148;6396.488280937607;7143.428525717826;7703.845923081619;7793.1427542969095;7846.764597062097;8684.956575217084;8718.60766265507;8764.780880477783;8768.25469835071;8783.868241976248;7658.540487570764;7839.686412543662;7861.960690196513;7901.762947111596;7921.445498815027;7522.774316770506;7586.089669239726;7590.240975902366;7714.459987801025;7715.884261735966;7096.1839388468925;7151.53515021522;7221.386182174364;7221.386182174574;7243.601601911945;5046.369203849519;5074.873128171826;5203.531682148625;5277.4194838566955;5290.68255904647;4787.3776409066595;5246.291750613771;5258.763355648928;5289.841304760864;5382.165764306539 09:20:14 INFO - PROCESS | 1658 | |4;prototype.html;301.18078825594375;306.606011275511;316.28835120977806;316.87325069972024;317.78390694327845;4606.884827879305;4965.230389289657;5500.559955203584;5580.637258578189;5698.487136157745;5049.64652474327;5250.6324557281005;5383.380911195214;5583.5254003409755;5635.154726790973;4265.488141423026;4293.347061381375;4295.677824163185;4296.312589985603;4350.173467041268;3430.7598468107244;4171.103212809246;4315.201687687772;4318.546552611978;4324.762138082404;3702.9444558331647;4189.664826813848;4213.431186789775;4222.19778242133;4240.681948853833;3716.1638631307874;4030.234255491447;4229.175310814392;4238;4239.258129827299;2856.0289501569564;3487.9825600872086;3718.5723641781;3723.7393382463238;3746.1571146492092;5315.229291752674;5377.7144713497;5408.188771684239;5426.484483974016;5528.308961379827;4505.986153115556;4876.975615121937;4901.411830580318;4915.016996600659;4936.259561065833;5018.623603229772;5830.47525722687;5871.530277577784;5883.117532370136;5885.676287804169;3933.4886464759684;4065.6340929316207;4068.3083875741195;4080.18396320737;4087.2234275487563;5828.854278643068;5908.320543137508;6110.266767987825;6200.852842224158;6226.59527130735;4106.527749308808;4114.547399786021;4131.772752498581;4138.13099249155;4146.030635448138;4208.516020657664;4211.894702632398;4220.409142720022;4223.68322375823;4246.363045543193;4732.178111427125;4902.583280421133;4913.484084171182;4923.409190897115;4933.827316043921;5420.783168673209;5934.406559344031;5941.851453713692;5978.774351257982;5986.700664966821;1242.167747609104;1394.8674875886977;1445.7180849734411;1445.8915581331441;1448.2758620689656;732.6300218389679;789.7907054630527;833.9041010283895;875.3916028360355;886.2599729226168;3836.9808150959625;4372.475302963601;4523.298888672195;4591.517890621503;4609.7695115244105;4747.839732921512;4917.926231106536;5107.387113546398;5137.737536664245;5143.27994080829;4051.3517837145914;4179.937300940488;4439.178751930903;4441.422615060086;4655.811768468814;2546.2870396289068;2621.4494956059443;2772.002079251468;3152.7793054486424;3206.765395322771;5476.58925580583;6256.092866534327;6346.936530634727;6428.32863455505;6451.870962580816;5024.32171656829;5525.171224316385;5945.346011938684;6251.906221406683;6253.624782513064;5085.415177254663;5591.46881046308;5905.763769449174;6087.29996050451;6441.194850643669;5830.708464576669;6110.541709371903;6128.233970753656;6147.446729794161;6153.446189842935;5324.627276090791;6033.396660334107;6045.153678484928;6086.69566521681;6101.786437474667;6125.816225513242;6164.6917654118015;6361.2048493938255;6379.298277189599;6381.755557666211;3860.594637563128;4008.518977722692;4019.718619696593;4040.4343391924567;4048.935043127967;5290.81482148123;5946.791862284799;6061.393860613904;6067.605605635619;6148.600340977822;5894.322152952465;5913.497352725067;5973.761049557969;5991.400859914148;6021.170050076457;5887.558433117619;5916.852078697895;5986.341502434816;5993.4006599341465;6008.759649613967;5582.581306402118;5690.268671038008;5826.155207494805;5863.472287493975;5874.500667443315;5465.9726701366235;5494.642848214853;5888.676122813115;5989.3711160329285;6015.909761353671;4662.580367766917;5078.593712503065;5530.308711411074;5782.335031471266;5851.297844258716 09:20:14 INFO - PROCESS | 1658 | |5;yui.html;654.5221987948797;684.1482354468684;745.4967896669748;778.171247621283;877.0177401310533;15411;15790.210489475538;15884.523464296075;15889.046657200575;15926.442574509894;12060.155789094766;13007.869921300784;14217.502387416442;14364.425422983068;14374;872.9781755456116;880.0671288434248;898.4384759525296;901.3059943843236;927.2998885841181;909.4043401571981;913.5843191347954;919.889613246408;920.0477505781517;929.0941332201083;967.6661551764665;969.4958621516807;969.92725545584;972.3096601413005;975.2441857560376;934.1779234273796;959.8464245720651;961.0101595356793;963.3256720295786;967.0667805567591;712.6080655639429;720.6432815756182;724.4277021153282;725.7750097469801;726.2918654312057;16100.919495402564;16101.516954491384;16105.677886442323;16129.516114516584;16161.434349797819;14298.356573954197;14539.418423263056;14570.635734106627;14650.70698586033;14759.557213283619;11289.830652540219;12173.513059477698;12440.688982775413;12515.937420312932;12525.43635536394;3809.9238015239816;3825.9617403825882;4020.798960051986;4039.6768258539246;4042.7170098093147;111997.88002120037;115391;115947.42026289814;116215;121347.393263034;11026.834597481044;11048.889511104946;11098;11176.720581985515;11204.047655949173;22203;22855.428614284443;22900.770992290196;22920.08319667228;22930;8038.115807261197;8126.715564955198;8222.794430139294;8244;8338.416310858182;4554.544545545486;4608.5621865922685;4637.049404871993;4677.672562920563;4774.570288674036;3632.5651367709606;3719.9814000929823;3748.0629842539365;3750.8124593770203;3754.2303827715255;637.9521535884735;649.2663290481726;656.9934300657028;668.4852663449117;670.2426258328155;521.4472658981492;671.5769065488711;675.7128220506265;686.629220221085;703.3704834173386;7532.510386824839;7630.618469076524;8010.759677209693;8319.542425166674;9580.37727547721;628.3182746719768;639.1531221132019;656.6552559906088;691.8305015271291;706.9575825450489;4744.383230180124;4793.712377257376;4809.374781278411;4825.083234185494;4832.4684284728655;144512.27743861423;153855.23072384566;155238.67141992878;156635;160462;83338.74991875127;105950.4702476498;128417;129082;131983;101989;106299.46850265854;106370;106835;106917.46541267243;7154.821129471805;8492.575371231538;9081.395291165012;9103.635854565744;9184.265258779147;56081.439185609255;65249.67375163094;66320;66364.6681766588;66628.66742665216;96304;99898;99925.50037249767;100022;101402.42286674304;11293.265937714023;11631.53473861036;11888.821667675165;11953.342566158944;12021;13614.319284035957;13638;13747.518836840663;13960.092593981359;13969;10441.791164176522;13104.606861794162;13118.934405327913;13166.868331316564;13167.407466664215;12048.638540843789;12568.685782855502;12962.481500740241;12970.286634235208;12972;11962.58130965412;12404.937975310066;12426.81359779586;12451.626451206479;12843.550475733304;10682.359058456517;10856.945715271373;10889.673309800719;11128.610498632508;11411.288306754053;10764.730881727706;10918.617848375268;10933.289336193122;10963.232573719763;10989.395583242998 09:20:14 INFO - PROCESS | 1658 | __end_tp_report 09:20:14 INFO - PROCESS | 1658 | __start_cc_report 09:20:14 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,437 09:20:14 INFO - PROCESS | 1658 | __end_cc_report 09:20:14 INFO - PROCESS | 1658 | __startTimestamp1467994814100__endTimestamp 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | ------- Summary: start ------- 09:20:14 INFO - PROCESS | 1658 | Number of tests: 6 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5579.93 Median:5822.18 stddev:784.32 (13.5%) stddev-sans-first:767.43 09:20:14 INFO - PROCESS | 1658 | Values: 3376.1 3377.9 3398.3 3402.2 3416.4 5642.0 5727.9 5749.9 5750.4 5822.2 4372.6 4894.8 5527.0 5738.2 5773.9 5137.3 5185.9 5261.1 5321.1 5351.6 352.3 5232.9 5248.9 5258.4 5312.0 3840.8 5162.8 5205.4 5209.5 5288.9 5132.3 5219.5 5232.5 5241.7 5266.5 4306.4 5121.4 5193.2 5216.7 5230.1 3988.9 5685.4 5727.8 5759.3 5760.8 4789.6 6023.1 6100.5 6115.7 6193.4 6162.3 6182.1 6185.0 6192.4 6195.3 5737.2 5737.5 5749.6 5750.5 5800.2 5231.2 5477.6 6123.6 6174.4 6188.1 5003.7 5906.1 6096.7 6118.4 6128.8 6111.1 6178.9 6179.4 6181.6 6196.9 6011.7 6075.2 6078.0 6125.8 6136.1 6020.1 6037.2 6060.4 6072.2 6103.0 4857.9 4865.7 4871.3 4891.5 4915.5 4296.5 4350.0 4373.3 4377.4 4468.8 4786.3 5801.9 5869.6 5888.5 5919.2 6190.2 6200.5 6202.5 6210.0 6227.7 5646.2 5769.4 5855.8 5872.3 5889.5 5387.8 5399.2 5402.0 5422.1 5434.2 6239.9 6260.2 6266.3 6271.6 6292.2 6111.3 6112.1 6129.3 6152.5 6184.8 6146.7 6183.7 6211.4 6222.6 6252.6 4423.5 5980.3 6072.2 6078.1 6079.6 6049.9 6133.2 6166.7 6187.6 6211.8 5152.7 6014.5 6051.0 6069.4 6148.4 5439.5 5805.4 6093.9 6094.1 6099.8 5193.5 5374.6 5422.8 5428.5 5800.3 6009.3 6020.0 6055.4 6063.8 6111.7 5055.4 5924.7 5938.1 5951.5 5956.0 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:69942.04 Median:38119.71 stddev:162121.60 (425.3%) stddev-sans-first:162492.54 09:20:14 INFO - PROCESS | 1658 | Values: 495.2 511.4 514.9 529.9 541.9 33137.0 37538.2 38723.2 38726.6 38737.6 39374.0 39539.2 40284.8 40316.8 40383.4 9124.3 9337.9 9347.3 9353.3 9370.9 9497.4 9553.0 9592.0 9593.1 9644.8 9537.2 9596.9 9636.7 9655.1 9683.0 9544.6 9608.5 9614.8 9629.0 9643.0 8101.0 9482.2 9575.0 9586.2 9594.6 38182.6 38299.0 38485.4 38541.8 38770.0 2710.0 3319.9 3349.0 3560.8 3642.3 30645.4 30647.0 31183.0 31393.5 31427.4 3097.8 3103.5 3117.6 3120.0 3224.9 425047.9 433676.0 462743.7 467533.0 468371.0 32958.7 32976.5 33015.0 33738.5 34438.7 34474.3 34742.0 34836.1 34916.8 35023.6 12933.9 15042.9 15151.2 15163.6 15165.1 10875.3 12802.3 12955.2 12957.6 13160.9 7375.6 7586.8 7598.3 7606.4 7632.2 2934.6 2963.9 3000.4 3193.5 3197.8 947.3 1007.8 1041.5 1078.6 1132.0 29707.9 29894.9 30091.5 30130.8 30960.7 938.5 999.0 1026.2 1068.8 1103.1 13411.0 14933.6 15132.0 15243.9 15559.7 684221.0 689561.0 694426.5 699247.0 702180.0 55904.4 56125.2 56841.4 56888.4 57311.4 1394.9 1417.5 1423.8 1433.9 1444.3 28864.0 28897.0 29060.9 29669.7 29694.4 49075.0 49640.0 50239.5 50315.5 50370.0 623579.0 625655.0 642860.0 644931.0 648896.0 25572.9 25632.1 25788.7 25908.9 26133.9 45407.0 45589.5 45720.3 46244.0 46940.5 37983.0 38117.8 38783.8 39173.2 39249.8 38067.9 38121.6 38205.0 38592.0 38771.8 33164.3 36572.8 36884.1 37314.0 39024.8 31137.8 33079.5 33509.8 34117.8 34163.8 24974.4 25013.0 25019.6 25228.6 25515.0 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:36789.78 Median:353.30 stddev:106295.34 (30086.3%) stddev-sans-first:106558.24 09:20:14 INFO - PROCESS | 1658 | Values: 316.4 325.3 381.3 382.5 393.6 18083.4 20252.5 20283.9 21392.7 21697.3 17537.1 19916.8 20755.0 20776.8 21055.9 5244.7 5859.7 5935.4 6050.8 6051.8 5828.7 5952.0 6000.6 6024.7 6039.7 5839.5 5841.1 5948.7 5968.1 5978.4 5780.4 5931.3 5933.0 5934.0 5934.3 4493.3 5089.7 5172.7 5426.3 5436.3 11080.1 12957.5 13237.6 13286.3 13458.9 2189.3 2205.1 2305.7 2311.5 2798.4 9676.5 9753.8 9966.1 9968.8 10180.8 1783.3 1811.5 1825.2 1862.6 1900.6 130011.0 132768.0 133189.3 135684.3 137639.0 11050.5 11219.7 11224.3 11490.9 11637.8 13274.5 14372.2 14397.9 14423.7 14526.0 6729.9 8290.8 8599.8 8698.7 8755.9 8666.1 8732.7 8740.0 8845.3 8865.5 4447.5 4471.7 4535.1 4540.8 4563.3 1901.8 1935.3 1948.6 1954.0 1956.4 820.8 890.4 906.7 924.0 980.8 20208.0 21030.0 21051.3 21168.3 21326.5 751.5 890.5 926.6 960.8 1026.1 9647.2 10228.6 10548.4 11079.5 11102.8 624376.9 625069.0 635651.0 639837.0 645177.0 112862.4 132318.0 137427.4 140605.0 142008.0 931.8 969.7 987.3 988.6 997.1 15907.8 18719.0 19102.0 19148.6 19563.7 57923.8 60435.4 60577.7 61896.4 62294.0 90438.0 90778.5 90880.0 91303.6 91809.0 7120.2 7589.2 7627.6 7993.4 8398.8 9468.2 13384.5 13667.6 13753.8 13956.8 10069.0 11535.5 11622.6 11803.0 11859.9 11564.9 11604.4 11611.8 11678.3 11692.3 5926.2 11834.5 11892.9 11964.8 11997.3 7516.7 7558.7 7583.7 7626.7 7814.8 11780.8 11803.5 11815.2 11839.8 11856.6 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5791.17 Median:4931.54 stddev:3271.02 (66.3%) stddev-sans-first:3264.31 09:20:14 INFO - PROCESS | 1658 | Values: 1502.3 1549.3 1788.2 1911.2 1926.5 8160.9 8701.1 8771.1 9187.1 9196.6 8864.2 8887.2 9035.4 9053.7 9093.1 2056.4 2326.6 2369.5 2385.7 2391.9 2357.1 2361.9 2389.0 2393.0 2405.0 2368.9 2376.7 2387.0 2394.4 2402.5 2359.6 2366.8 2379.9 2386.6 2387.9 2337.9 2338.3 2357.6 2383.8 2386.6 9127.6 9211.3 9229.0 9242.0 9243.3 5346.0 5508.1 5528.5 5529.6 5541.3 3498.1 3609.2 3673.5 3675.0 3675.9 906.4 969.4 1076.0 1082.5 1103.3 10635.8 11647.4 11810.0 11925.5 11943.7 4484.5 4511.5 4630.8 4664.4 4688.6 8125.3 9356.1 9387.2 9400.2 9410.7 5186.6 5192.2 5280.0 5334.6 5349.8 4460.6 4850.3 4864.6 4998.5 5005.8 3788.7 3844.1 3882.6 3918.6 3960.4 1171.7 1175.1 1177.7 1187.6 1187.9 929.0 936.9 937.7 944.5 992.1 5079.4 6095.5 6144.4 6180.1 6220.3 436.3 440.3 451.2 452.5 459.7 4111.1 4150.9 4153.3 4164.5 4195.1 10104.6 10923.7 10977.4 11055.9 11062.8 10803.5 10806.6 11045.9 11080.7 11099.6 7946.3 8314.4 8359.1 8383.9 8408.4 5250.7 6143.3 6181.5 6245.2 6258.8 9223.6 10354.5 10372.3 10392.1 10401.0 10098.0 10223.8 10512.2 10633.3 10670.6 6396.5 7143.4 7703.8 7793.1 7846.8 8685.0 8718.6 8764.8 8768.3 8783.9 7658.5 7839.7 7862.0 7901.8 7921.4 7522.8 7586.1 7590.2 7714.5 7715.9 7096.2 7151.5 7221.4 7221.4 7243.6 5046.4 5074.9 5203.5 5277.4 5290.7 4787.4 5246.3 5258.8 5289.8 5382.2 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:4718.38 Median:5122.56 stddev:1481.00 (28.9%) stddev-sans-first:1447.57 09:20:14 INFO - PROCESS | 1658 | Values: 301.2 306.6 316.3 316.9 317.8 4606.9 4965.2 5500.6 5580.6 5698.5 5049.6 5250.6 5383.4 5583.5 5635.2 4265.5 4293.3 4295.7 4296.3 4350.2 3430.8 4171.1 4315.2 4318.5 4324.8 3702.9 4189.7 4213.4 4222.2 4240.7 3716.2 4030.2 4229.2 4238.0 4239.3 2856.0 3488.0 3718.6 3723.7 3746.2 5315.2 5377.7 5408.2 5426.5 5528.3 4506.0 4877.0 4901.4 4915.0 4936.3 5018.6 5830.5 5871.5 5883.1 5885.7 3933.5 4065.6 4068.3 4080.2 4087.2 5828.9 5908.3 6110.3 6200.9 6226.6 4106.5 4114.5 4131.8 4138.1 4146.0 4208.5 4211.9 4220.4 4223.7 4246.4 4732.2 4902.6 4913.5 4923.4 4933.8 5420.8 5934.4 5941.9 5978.8 5986.7 1242.2 1394.9 1445.7 1445.9 1448.3 732.6 789.8 833.9 875.4 886.3 3837.0 4372.5 4523.3 4591.5 4609.8 4747.8 4917.9 5107.4 5137.7 5143.3 4051.4 4179.9 4439.2 4441.4 4655.8 2546.3 2621.4 2772.0 3152.8 3206.8 5476.6 6256.1 6346.9 6428.3 6451.9 5024.3 5525.2 5945.3 6251.9 6253.6 5085.4 5591.5 5905.8 6087.3 6441.2 5830.7 6110.5 6128.2 6147.4 6153.4 5324.6 6033.4 6045.2 6086.7 6101.8 6125.8 6164.7 6361.2 6379.3 6381.8 3860.6 4008.5 4019.7 4040.4 4048.9 5290.8 5946.8 6061.4 6067.6 6148.6 5894.3 5913.5 5973.8 5991.4 6021.2 5887.6 5916.9 5986.3 5993.4 6008.8 5582.6 5690.3 5826.2 5863.5 5874.5 5466.0 5494.6 5888.7 5989.4 6015.9 4662.6 5078.6 5530.3 5782.3 5851.3 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:24889.37 Median:13281.28 stddev:39894.82 (300.4%) stddev-sans-first:39965.24 09:20:14 INFO - PROCESS | 1658 | Values: 654.5 684.1 745.5 778.2 877.0 15411.0 15790.2 15884.5 15889.0 15926.4 12060.2 13007.9 14217.5 14364.4 14374.0 873.0 880.1 898.4 901.3 927.3 909.4 913.6 919.9 920.0 929.1 967.7 969.5 969.9 972.3 975.2 934.2 959.8 961.0 963.3 967.1 712.6 720.6 724.4 725.8 726.3 16100.9 16101.5 16105.7 16129.5 16161.4 14298.4 14539.4 14570.6 14650.7 14759.6 11289.8 12173.5 12440.7 12515.9 12525.4 3809.9 3826.0 4020.8 4039.7 4042.7 111997.9 115391.0 115947.4 116215.0 121347.4 11026.8 11048.9 11098.0 11176.7 11204.0 22203.0 22855.4 22900.8 22920.1 22930.0 8038.1 8126.7 8222.8 8244.0 8338.4 4554.5 4608.6 4637.0 4677.7 4774.6 3632.6 3720.0 3748.1 3750.8 3754.2 638.0 649.3 657.0 668.5 670.2 521.4 671.6 675.7 686.6 703.4 7532.5 7630.6 8010.8 8319.5 9580.4 628.3 639.2 656.7 691.8 707.0 4744.4 4793.7 4809.4 4825.1 4832.5 144512.3 153855.2 155238.7 156635.0 160462.0 83338.7 105950.5 128417.0 129082.0 131983.0 101989.0 106299.5 106370.0 106835.0 106917.5 7154.8 8492.6 9081.4 9103.6 9184.3 56081.4 65249.7 66320.0 66364.7 66628.7 96304.0 99898.0 99925.5 100022.0 101402.4 11293.3 11631.5 11888.8 11953.3 12021.0 13614.3 13638.0 13747.5 13960.1 13969.0 10441.8 13104.6 13118.9 13166.9 13167.4 12048.6 12568.7 12962.5 12970.3 12972.0 11962.6 12404.9 12426.8 12451.6 12843.6 10682.4 10856.9 10889.7 11128.6 11411.3 10764.7 10918.6 10933.3 10963.2 10989.4 09:20:14 INFO - PROCESS | 1658 | -------- Summary: end -------- 09:20:14 INFO - PROCESS | 1658 | 09:20:14 INFO - TEST-INFO | 1658: exit 0 09:20:14 INFO - TEST-OK | dromaeo_css | took 1112121ms 09:20:14 INFO - TEST-START | kraken 09:20:14 INFO - operating with platform_type : mac_ 09:20:14 INFO - Initialising browser for kraken test... 09:20:14 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmphizxYy/profile http://localhost:49282/getInfo.html) 09:20:17 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 09:20:17 INFO - PROCESS | 1667 | colorDepth:24 09:20:17 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 09:20:17 INFO - PROCESS | 1667 | __metrics 09:20:17 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 09:20:18 INFO - TEST-INFO | 1667: exit 0 09:20:18 INFO - Browser initialized. 09:20:18 INFO - Running cycle 1/1 for kraken test... 09:20:18 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/T/tmphizxYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:30 INFO - PROCESS | 1669 | RSS: Main: 254164992 09:20:30 INFO - PROCESS | 1669 | 09:20:33 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection) 09:20:34 INFO - PROCESS | 1669 | RSS: Main: 267444224 09:20:34 INFO - PROCESS | 1669 | 09:20:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-dft) 09:20:37 INFO - PROCESS | 1669 | RSS: Main: 271388672 09:20:37 INFO - PROCESS | 1669 | 09:20:40 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-fft) 09:20:41 INFO - PROCESS | 1669 | RSS: Main: 271388672 09:20:41 INFO - PROCESS | 1669 | 09:20:43 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator) 09:20:44 INFO - PROCESS | 1669 | RSS: Main: 272875520 09:20:44 INFO - PROCESS | 1669 | 09:20:46 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:20:47 INFO - PROCESS | 1669 | RSS: Main: 272924672 09:20:47 INFO - PROCESS | 1669 | 09:20:50 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom) 09:20:50 INFO - PROCESS | 1669 | RSS: Main: 273518592 09:20:50 INFO - PROCESS | 1669 | 09:20:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate) 09:20:54 INFO - PROCESS | 1669 | RSS: Main: 274083840 09:20:54 INFO - PROCESS | 1669 | 09:20:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial) 09:20:58 INFO - PROCESS | 1669 | RSS: Main: 273825792 09:20:58 INFO - PROCESS | 1669 | 09:20:59 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:21:00 INFO - PROCESS | 1669 | RSS: Main: 274313216 09:21:00 INFO - PROCESS | 1669 | 09:21:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:21:02 INFO - PROCESS | 1669 | RSS: Main: 274337792 09:21:02 INFO - PROCESS | 1669 | 09:21:05 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:21:05 INFO - PROCESS | 1669 | RSS: Main: 273674240 09:21:05 INFO - PROCESS | 1669 | 09:21:08 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:21:09 INFO - PROCESS | 1669 | RSS: Main: 273965056 09:21:09 INFO - PROCESS | 1669 | 09:21:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:21:12 INFO - PROCESS | 1669 | RSS: Main: 273367040 09:21:12 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49282/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49282/tests/kraken/driver.html?testName=ai-astar) 09:21:14 INFO - PROCESS | 1669 | RSS: Main: 274173952 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | __start_tp_report 09:21:14 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 09:21:14 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 09:21:14 INFO - PROCESS | 1669 | |i|pagename|runs| 09:21:14 INFO - PROCESS | 1669 | |0;ai-astar;103;117;108;128;144;164;160;139;114;118 09:21:14 INFO - PROCESS | 1669 | |1;audio-beat-detection;147;104;161;182;120;151;158;96;188;141 09:21:14 INFO - PROCESS | 1669 | |2;audio-dft;228;204;197;259;256;200;211;274;185;185 09:21:14 INFO - PROCESS | 1669 | |3;audio-fft;67;90;103;147;75;71;57;74;151;80 09:21:14 INFO - PROCESS | 1669 | |4;audio-oscillator;71;72;157;99;73;74;110;70;71;124 09:21:14 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;92;90;83;101;133;97;131;82;134;130 09:21:14 INFO - PROCESS | 1669 | |6;imaging-darkroom;147;130;104;98;133;150;98;99;97;103 09:21:14 INFO - PROCESS | 1669 | |7;imaging-desaturate;88;90;90;93;93;87;89;95;92;91 09:21:14 INFO - PROCESS | 1669 | |8;json-parse-financial;57;59;56;56;59;59;51;61;63;87 09:21:14 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;69;77;68;75;72;73;77;68;68;71 09:21:14 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;87;86;86;87;85;84;98;110;98;106 09:21:14 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;139;148;154;133;137;137;135;141;175;140 09:21:14 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;221;172;167;166;164;164;166;161;164;156 09:21:14 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;69;69;67;66;67;68;70;64;66;67 09:21:14 INFO - PROCESS | 1669 | __end_tp_report 09:21:14 INFO - PROCESS | 1669 | __start_cc_report 09:21:14 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1136 09:21:14 INFO - PROCESS | 1669 | __end_cc_report 09:21:14 INFO - PROCESS | 1669 | __startTimestamp1467994874624__endTimestamp 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | ------- Summary: start ------- 09:21:14 INFO - PROCESS | 1669 | Number of tests: 14 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:129.50 Median:133.50 stddev:21.39 (16.0%) stddev-sans-first:20.42 09:21:14 INFO - PROCESS | 1669 | Values: 103.0 117.0 108.0 128.0 144.0 164.0 160.0 139.0 114.0 118.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:144.80 Median:159.50 stddev:30.56 (19.2%) stddev-sans-first:32.40 09:21:14 INFO - PROCESS | 1669 | Values: 147.0 104.0 161.0 182.0 120.0 151.0 158.0 96.0 188.0 141.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:219.90 Median:219.50 stddev:32.51 (14.8%) stddev-sans-first:34.35 09:21:14 INFO - PROCESS | 1669 | Values: 228.0 204.0 197.0 259.0 256.0 200.0 211.0 274.0 185.0 185.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:91.50 Median:72.50 stddev:32.79 (45.2%) stddev-sans-first:33.56 09:21:14 INFO - PROCESS | 1669 | Values: 67.0 90.0 103.0 147.0 75.0 71.0 57.0 74.0 151.0 80.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:71.50 stddev:29.95 (41.9%) stddev-sans-first:30.78 09:21:14 INFO - PROCESS | 1669 | Values: 71.0 72.0 157.0 99.0 73.0 74.0 110.0 70.0 71.0 124.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:82.50 stddev:22.01 (26.7%) stddev-sans-first:22.64 09:21:14 INFO - PROCESS | 1669 | Values: 92.0 90.0 83.0 101.0 133.0 97.0 131.0 82.0 134.0 130.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:115.90 Median:123.50 stddev:21.64 (17.5%) stddev-sans-first:19.81 09:21:14 INFO - PROCESS | 1669 | Values: 147.0 130.0 104.0 98.0 133.0 150.0 98.0 99.0 97.0 103.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:90.80 Median:91.50 stddev:2.49 (2.7%) stddev-sans-first:2.42 09:21:14 INFO - PROCESS | 1669 | Values: 88.0 90.0 90.0 93.0 93.0 87.0 89.0 95.0 92.0 91.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:59.00 stddev:9.76 (16.5%) stddev-sans-first:10.26 09:21:14 INFO - PROCESS | 1669 | Values: 57.0 59.0 56.0 56.0 59.0 59.0 51.0 61.0 63.0 87.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:71.80 Median:72.50 stddev:3.61 (5.0%) stddev-sans-first:3.69 09:21:14 INFO - PROCESS | 1669 | Values: 69.0 77.0 68.0 75.0 72.0 73.0 77.0 68.0 68.0 71.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:86.50 stddev:9.56 (11.0%) stddev-sans-first:9.91 09:21:14 INFO - PROCESS | 1669 | Values: 87.0 86.0 86.0 87.0 85.0 84.0 98.0 110.0 98.0 106.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:140.50 stddev:12.59 (9.0%) stddev-sans-first:13.23 09:21:14 INFO - PROCESS | 1669 | Values: 139.0 148.0 154.0 133.0 137.0 137.0 135.0 141.0 175.0 140.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:166.00 stddev:18.35 (11.1%) stddev-sans-first:4.36 09:21:14 INFO - PROCESS | 1669 | Values: 221.0 172.0 167.0 166.0 164.0 164.0 166.0 161.0 164.0 156.0 09:21:14 INFO - PROCESS | 1669 | 09:21:14 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.77 (2.6%) stddev-sans-first:1.76 09:21:14 INFO - PROCESS | 1669 | Values: 69.0 69.0 67.0 66.0 67.0 68.0 70.0 64.0 66.0 67.0 09:21:14 INFO - PROCESS | 1669 | -------- Summary: end -------- 09:21:14 INFO - PROCESS | 1669 | 09:21:15 INFO - TEST-INFO | 1669: exit 0 09:21:15 INFO - TEST-OK | kraken | took 60740ms 09:21:15 INFO - SUITE-END | took 1172s 09:21:15 INFO - Completed test suite (00:19:33) 09:21:15 INFO - javascript benchmark 09:21:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7247.691818913018, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3376.054704682689, 3377.864885404584, 3398.3033478136986, 3402.234497238121, 3416.385050690876, 5641.971790141049, 5727.856803579913, 5749.942500574993, 5750.3962083981205, 5822.184894114822, 4372.60646541812, 4894.800773810422, 5526.972365138179, 5738.196652468658, 5773.913391299134, 5137.3064636274, 5185.896282074356, 5261.053010458116, 5321.095413779667, 5351.625386222966, 352.26161207603025, 5232.8691782705355, 5248.947510524884, 5258.395284542288, 5312.0, 3840.7503512271614, 5162.845114646567, 5205.37535495741, 5209.479052094798, 5288.867778305535, 5132.332796736438, 5219.530242278213, 5232.450592687751, 5241.711705856176, 5266.473352664703, 4306.418633484503, 5121.359830021247, 5193.195054766479, 5216.66091704038, 5230.137027390476, 3988.940165897514, 5685.374608793029, 5727.770889164429, 5759.280089988752, 5760.7695692172265, 4789.592884604813, 6023.066424704134, 6100.542459315569, 6115.663638499881, 6193.38066193377, 6162.260528736536, 6182.1345011698395, 6185.0, 6192.411720886508, 6195.256569211723, 5737.2254745609225, 5737.512311453532, 5749.626274292157, 5750.482456578844, 5800.245968024172, 5231.215317702375, 5477.643953143033, 6123.618175568305, 6174.44430001302, 6188.133661287423, 5003.674761140514, 5906.114082887515, 6096.69516524172, 6118.357572454917, 6128.816135515942, 6111.052786818051, 6178.938210617926, 6179.443850053517, 6181.629102253879, 6196.907046394308, 6011.729472173763, 6075.179850720185, 6077.96674565325, 6125.816225513242, 6136.110264011693, 6020.096985452217, 6037.215162028908, 6060.363661815534, 6072.240969878765, 6102.969485152635, 4857.854264372075, 4865.659403841768, 4871.269309603588, 4891.461939186686, 4915.459299477055, 4296.484421869396, 4349.978250108729, 4373.343998400265, 4377.430933978562, 4468.776561171929, 4786.2820576913045, 5801.854953626109, 5869.559783016291, 5888.499477544457, 5919.230500034968, 6190.226221722285, 6200.472959798378, 6202.472789812826, 6210.037444196157, 6227.688615569204, 5646.2377579027125, 5769.423057694197, 5855.824325270249, 5872.324682661549, 5889.469947704727, 5387.757550910218, 5399.190121481731, 5401.972990135103, 5422.078246698071, 5434.157705555645, 6239.937600623935, 6260.154879091265, 6266.342034086447, 6271.623702577769, 6292.182016337847, 6111.348653136637, 6112.083187521907, 6129.325774164928, 6152.538559607958, 6184.81445556634, 6146.723397447036, 6183.659898705434, 6211.378862113753, 6222.564420490522, 6252.624842509464, 4423.518121429229, 5980.3421623622235, 6072.180255665606, 6078.149059131813, 6079.635221886701, 6049.879002420015, 6133.2428548619655, 6166.660833654192, 6187.597806142587, 6211.81364559064, 5152.690838549699, 6014.488768454556, 6050.969745151246, 6069.362716914837, 6148.354422785722, 5439.48324909133, 5805.419458054161, 6093.908591371044, 6094.146819445193, 6099.817005489843, 5193.480651934777, 5374.623776335619, 5422.755975981011, 5428.4842939920645, 5800.274965629296, 6009.308929473166, 6019.969900150471, 6055.364186760326, 6063.818085457443, 6111.724972376165, 5055.418626857959, 5924.7037648118285, 5938.079597662369, 5951.494122999594, 5956.047032474783], "value": 5537.486368215938, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [495.2126119470043, 511.442527644867, 514.9021685879683, 529.9470052994699, 541.8807862270302, 33137.00588982328, 37538.24923501528, 38723.22553548928, 38726.61273387265, 38737.612623873756, 39374.0, 39539.20921581567, 40284.79857600708, 40316.79841600795, 40383.39424908629, 9124.31567632427, 9337.906620933805, 9347.252219822432, 9353.298502612332, 9370.85943710845, 9497.430154190735, 9553.044695530427, 9591.952040239825, 9593.088656577649, 9644.758881027996, 9537.189338906166, 9596.856047159297, 9636.710898673016, 9655.13103820656, 9683.031696830296, 9544.61821527138, 9608.501789534701, 9614.807703845954, 9629.0, 9642.951785241028, 8101.0, 9482.19401350886, 9574.952125239399, 9586.233101351874, 9594.616215351378, 38182.618173818184, 38299.0, 38485.42271865924, 38541.80729096365, 38770.0, 2709.972900270992, 3319.867205311785, 3348.983255083709, 3560.8219589020705, 3642.3079614873354, 30645.387092258254, 30647.0, 31183.0, 31393.52909706356, 31427.37145257082, 3097.814131152138, 3103.5499852521257, 3117.579126817873, 3120.0, 3224.871005159791, 425047.87476062734, 433676.0, 462743.6862815698, 467532.9999999966, 468371.0, 32958.67041329556, 32976.505352419736, 33015.0, 33738.49392259069, 34438.65561344405, 34474.31051378958, 34741.957741267805, 34836.129096772784, 34916.82541587276, 35023.64976350255, 12933.935330323477, 15042.924785376003, 15151.242437878062, 15163.620909477351, 15165.09009459436, 10875.347479151276, 12802.295873726847, 12955.222686638832, 12957.611271661865, 13160.934195329153, 7375.631218439056, 7586.810329741801, 7598.316151546387, 7606.3914886808925, 7632.1986191450205, 2934.618499595039, 2963.9110826675233, 3000.354923691417, 3193.499055443938, 3197.8401079946375, 947.303731757158, 1007.8437842134481, 1041.4844651897208, 1078.6332646900091, 1131.9773604527863, 29707.85146074299, 29894.85052574723, 30091.548626770615, 30130.84934575313, 30960.690393096233, 938.5166639180827, 998.9600415983425, 1026.235454586338, 1068.7755571330108, 1103.0844399148687, 13411.0, 14933.626659333604, 15132.010903085875, 15243.923780381027, 15559.688806223812, 684221.0, 689561.0, 694426.5278673575, 699247.0, 702180.0, 55904.44095559074, 56125.15812262819, 56841.43158568444, 56888.43111568914, 57311.426885731446, 1394.8884089272833, 1417.4684493315008, 1423.814904062486, 1433.9426422942965, 1444.2562080528537, 28863.989760359127, 28896.98860539871, 29060.854695726386, 29669.703302966693, 29694.406111877208, 49075.0, 49640.0, 50239.49760502348, 50315.49684503255, 50370.0, 623579.0, 625655.0, 642860.0, 644931.0, 648896.0441582473, 25572.8721356392, 25632.102876399236, 25788.742112578635, 25908.8704556476, 26133.869330653226, 45407.0, 45589.54410455853, 45720.31419528643, 46244.02606084237, 46940.53059469361, 37983.0, 38117.80941095277, 38783.806080969414, 39173.21653566856, 39249.8037509822, 38067.857964261115, 38121.61878381292, 38205.044873878374, 38592.0, 38771.806140969114, 33164.33671326512, 36572.81713591415, 36884.07789805276, 37314.0, 39024.80487597544, 31137.844310778302, 33079.50380744242, 33509.83245083759, 34117.829410852784, 34163.829180853936, 24974.37564060913, 25012.985456288345, 25019.624705629067, 25228.621570676823, 25514.97940082376], "value": 18179.463140943597, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.3988421998203, 325.27463755824505, 381.3288612042804, 382.48364707644686, 393.6221227621483, 18083.367082152126, 20252.493687657818, 20283.898580507095, 21392.679109813365, 21697.34907952762, 17537.123143842822, 19916.800831991677, 20755.0, 20776.792232077674, 21055.894720526416, 5244.711540865251, 5859.736311865966, 5935.436133567304, 6050.848728781772, 6051.818445446644, 5828.679422631753, 5951.970240148793, 6000.639961602296, 6024.7288872000645, 6039.667818269993, 5839.532837373, 5841.094630332284, 5948.702564871739, 5968.1346204800275, 5978.402159784008, 5780.393058728836, 5931.258592675916, 5933.0, 5933.970330148343, 5934.258217722785, 4493.281075028012, 5089.694618322913, 5172.689638621695, 5426.267453893753, 5436.320459942507, 11080.113590912708, 12957.48170073196, 13237.602871913761, 13286.3356832158, 13458.865411345958, 2189.321310393767, 2205.0848897707433, 2305.7233132024267, 2311.4914718762016, 2798.3703666674837, 9676.516174191262, 9753.756156096084, 9966.053224943618, 9968.750781230454, 10180.796384072277, 1783.3312507809571, 1811.4565630310985, 1825.196913358118, 1862.5995410986702, 1900.6008738165, 130011.0, 132768.0084798729, 133189.33405333105, 135684.32157839247, 137639.0, 11050.50818139541, 11219.66341009771, 11224.326540407601, 11490.942545287387, 11637.767244655059, 13274.535391261259, 14372.209528476034, 14397.856021439651, 14423.711525769426, 14526.0, 6729.92321228601, 8290.792730181794, 8599.828003440021, 8698.739037828875, 8755.912440875638, 8666.133386661284, 8732.65069397217, 8740.0, 8845.292376609856, 8865.468071915706, 4447.466304043535, 4471.709338892962, 4535.115652447807, 4540.79566419512, 4563.315502674559, 1901.7622797150357, 1935.332310352926, 1948.5518330783998, 1953.990230048869, 1956.3935180094215, 820.8016296207604, 890.3544929925752, 906.6735975048977, 923.9769005774909, 980.8332583460686, 20207.989600519915, 21030.0, 21051.263205787724, 21168.259110931045, 21326.466838329165, 751.5040073551539, 890.5057692980458, 926.5876684875166, 960.7550074730899, 1026.1329176845554, 9647.179989700813, 10228.619136416637, 10548.419836909045, 11079.50142243601, 11102.777944441066, 624376.8781156156, 625069.0, 635651.0, 639837.0, 645177.0, 112862.43568782268, 132318.0, 137427.44149071697, 140605.0, 142008.0, 931.8136372725482, 969.6606187834202, 987.3335498538457, 988.5847943863595, 997.0677416615488, 15907.761383579487, 18719.0, 19102.0, 19148.617027659646, 19563.706544402132, 57923.841523168456, 60435.395646042976, 60577.69711151416, 61896.38103619086, 62294.0, 90438.0, 90778.54610726904, 90880.0, 91303.6304455447, 91809.0, 7120.2167761547225, 7589.1651918290045, 7627.580483073484, 7993.400494962785, 8398.832023359377, 9468.242540596873, 13384.464621415034, 13667.589972300846, 13753.786562049878, 13956.790648140082, 10069.0, 11535.480903359201, 11622.593209237637, 11803.0, 11859.881401185878, 11564.94217528907, 11604.361760103275, 11611.825822612836, 11678.299302041905, 11692.298462092302, 5926.1999630049395, 11834.467448964646, 11892.940535297614, 11964.76070478603, 11997.280163190237, 7516.736914207976, 7558.735444259424, 7583.734569290048, 7626.656800443882, 7814.843703126019, 11780.82328765052, 11803.468843901874, 11815.172937894265, 11839.822402663794, 11856.585019524275], "value": 9454.687043947239, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.3014298351268, 1549.3028137338201, 1788.1595650044474, 1911.2259534888376, 1926.4509614759797, 8160.877586836202, 8701.129887011295, 8771.122887711226, 9187.081291870809, 9196.586153623079, 8864.15790499903, 8887.24458421035, 9035.412698174614, 9053.683121090764, 9093.13615206556, 2056.4139220322213, 2326.581215381231, 2369.4668699542553, 2385.725641551218, 2391.868447235401, 2357.0807385119815, 2361.9409514762183, 2389.0, 2392.988035059831, 2404.95190096198, 2368.857868527894, 2376.6791483149814, 2386.9761302387014, 2394.425337918896, 2402.531506356261, 2359.622460406344, 2366.751491093436, 2379.916702915398, 2386.606209975352, 2387.8925448354867, 2337.8714170720605, 2338.286822519131, 2357.622780355152, 2383.761623837602, 2386.6300723387903, 9127.634894604207, 9211.30915181364, 9229.030951750037, 9242.0, 9243.26053915685, 5345.9842629900195, 5508.118701007819, 5528.530074943635, 5529.585281103933, 5541.33503979521, 3498.1254686328416, 3609.187932715144, 3673.522442082539, 3674.963250367489, 3675.9448608270895, 906.3700727994046, 969.3602222533094, 1075.9515821788038, 1082.5290998415715, 1103.332483847277, 10635.840462393071, 11647.41762911851, 11809.996150327232, 11925.522979080826, 11943.701407464796, 4484.506704262529, 4511.548845115462, 4630.791614377361, 4664.39362882823, 4688.5545873142, 8125.3499720022255, 9356.111169438893, 9387.202087822476, 9400.200982916393, 9410.670626528039, 5186.611004174627, 5192.247124166975, 5280.0, 5334.5732341412595, 5349.786008559614, 4460.553944605514, 4850.272459131159, 4864.586510146677, 4998.500149984972, 5005.774740136702, 3788.677962373174, 3844.058205739556, 3882.611738826095, 3918.647321741057, 3960.3663413853646, 1171.6719318590808, 1175.1362748379934, 1177.7055736065984, 1187.5724739093919, 1187.9109066820024, 928.967486137982, 936.9344145909857, 937.6671281695036, 944.5230158769778, 992.0674565908023, 5079.4412614612365, 6095.4818840398175, 6144.354842741537, 6180.134781130645, 6220.346863579259, 436.32805479561756, 440.2999231222372, 451.2464184811373, 452.5429316390404, 459.65755512143, 4111.1366613011605, 4150.896227594334, 4153.293940030142, 4164.500259968823, 4195.056112374752, 10104.646337378303, 10923.672289831318, 10977.3962432067, 11055.949684779933, 11062.834057489144, 10803.459827008619, 10806.567737290421, 11045.889541104487, 11080.722981925355, 11099.556017759362, 7946.284834364935, 8314.41799074059, 8359.122292159236, 8383.916160838435, 8408.41141120128, 5250.65870718402, 6143.262808463013, 6181.474574661204, 6245.156903817927, 6258.780942666985, 9223.58493867791, 10354.482275886025, 10372.325798823053, 10392.116670082825, 10401.0, 10098.0, 10223.795524089328, 10512.211584131373, 10633.255672102878, 10670.62652807148, 6396.488280937607, 7143.428525717826, 7703.845923081619, 7793.1427542969095, 7846.764597062097, 8684.956575217084, 8718.60766265507, 8764.780880477783, 8768.25469835071, 8783.868241976248, 7658.540487570764, 7839.686412543662, 7861.960690196513, 7901.762947111596, 7921.445498815027, 7522.774316770506, 7586.089669239726, 7590.240975902366, 7714.459987801025, 7715.884261735966, 7096.1839388468925, 7151.53515021522, 7221.386182174364, 7221.386182174574, 7243.601601911945, 5046.369203849519, 5074.873128171826, 5203.531682148625, 5277.4194838566955, 5290.68255904647, 4787.3776409066595, 5246.291750613771, 5258.763355648928, 5289.841304760864, 5382.165764306539], "value": 4560.4663672103125, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.18078825594375, 306.606011275511, 316.28835120977806, 316.87325069972024, 317.78390694327845, 4606.884827879305, 4965.230389289657, 5500.559955203584, 5580.637258578189, 5698.487136157745, 5049.64652474327, 5250.6324557281005, 5383.380911195214, 5583.5254003409755, 5635.154726790973, 4265.488141423026, 4293.347061381375, 4295.677824163185, 4296.312589985603, 4350.173467041268, 3430.7598468107244, 4171.103212809246, 4315.201687687772, 4318.546552611978, 4324.762138082404, 3702.9444558331647, 4189.664826813848, 4213.431186789775, 4222.19778242133, 4240.681948853833, 3716.1638631307874, 4030.234255491447, 4229.175310814392, 4238.0, 4239.258129827299, 2856.0289501569564, 3487.9825600872086, 3718.5723641781, 3723.7393382463238, 3746.1571146492092, 5315.229291752674, 5377.7144713497, 5408.188771684239, 5426.484483974016, 5528.308961379827, 4505.986153115556, 4876.975615121937, 4901.411830580318, 4915.016996600659, 4936.259561065833, 5018.623603229772, 5830.47525722687, 5871.530277577784, 5883.117532370136, 5885.676287804169, 3933.4886464759684, 4065.6340929316207, 4068.3083875741195, 4080.18396320737, 4087.2234275487563, 5828.854278643068, 5908.320543137508, 6110.266767987825, 6200.852842224158, 6226.59527130735, 4106.527749308808, 4114.547399786021, 4131.772752498581, 4138.13099249155, 4146.030635448138, 4208.516020657664, 4211.894702632398, 4220.409142720022, 4223.68322375823, 4246.363045543193, 4732.178111427125, 4902.583280421133, 4913.484084171182, 4923.409190897115, 4933.827316043921, 5420.783168673209, 5934.406559344031, 5941.851453713692, 5978.774351257982, 5986.700664966821, 1242.167747609104, 1394.8674875886977, 1445.7180849734411, 1445.8915581331441, 1448.2758620689656, 732.6300218389679, 789.7907054630527, 833.9041010283895, 875.3916028360355, 886.2599729226168, 3836.9808150959625, 4372.475302963601, 4523.298888672195, 4591.517890621503, 4609.7695115244105, 4747.839732921512, 4917.926231106536, 5107.387113546398, 5137.737536664245, 5143.27994080829, 4051.3517837145914, 4179.937300940488, 4439.178751930903, 4441.422615060086, 4655.811768468814, 2546.2870396289068, 2621.4494956059443, 2772.002079251468, 3152.7793054486424, 3206.765395322771, 5476.58925580583, 6256.092866534327, 6346.936530634727, 6428.32863455505, 6451.870962580816, 5024.32171656829, 5525.171224316385, 5945.346011938684, 6251.906221406683, 6253.624782513064, 5085.415177254663, 5591.46881046308, 5905.763769449174, 6087.29996050451, 6441.194850643669, 5830.708464576669, 6110.541709371903, 6128.233970753656, 6147.446729794161, 6153.446189842935, 5324.627276090791, 6033.396660334107, 6045.153678484928, 6086.69566521681, 6101.786437474667, 6125.816225513242, 6164.6917654118015, 6361.2048493938255, 6379.298277189599, 6381.755557666211, 3860.594637563128, 4008.518977722692, 4019.718619696593, 4040.4343391924567, 4048.935043127967, 5290.81482148123, 5946.791862284799, 6061.393860613904, 6067.605605635619, 6148.600340977822, 5894.322152952465, 5913.497352725067, 5973.761049557969, 5991.400859914148, 6021.170050076457, 5887.558433117619, 5916.852078697895, 5986.341502434816, 5993.4006599341465, 6008.759649613967, 5582.581306402118, 5690.268671038008, 5826.155207494805, 5863.472287493975, 5874.500667443315, 5465.9726701366235, 5494.642848214853, 5888.676122813115, 5989.3711160329285, 6015.909761353671, 4662.580367766917, 5078.593712503065, 5530.308711411074, 5782.335031471266, 5851.297844258716], "value": 4236.772613414694, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.5221987948797, 684.1482354468684, 745.4967896669748, 778.171247621283, 877.0177401310533, 15411.0, 15790.210489475538, 15884.523464296075, 15889.046657200575, 15926.442574509894, 12060.155789094766, 13007.869921300784, 14217.502387416442, 14364.425422983068, 14374.0, 872.9781755456116, 880.0671288434248, 898.4384759525296, 901.3059943843236, 927.2998885841181, 909.4043401571981, 913.5843191347954, 919.889613246408, 920.0477505781517, 929.0941332201083, 967.6661551764665, 969.4958621516807, 969.92725545584, 972.3096601413005, 975.2441857560376, 934.1779234273796, 959.8464245720651, 961.0101595356793, 963.3256720295786, 967.0667805567591, 712.6080655639429, 720.6432815756182, 724.4277021153282, 725.7750097469801, 726.2918654312057, 16100.919495402564, 16101.516954491384, 16105.677886442323, 16129.516114516584, 16161.434349797819, 14298.356573954197, 14539.418423263056, 14570.635734106627, 14650.70698586033, 14759.557213283619, 11289.830652540219, 12173.513059477698, 12440.688982775413, 12515.937420312932, 12525.43635536394, 3809.9238015239816, 3825.9617403825882, 4020.798960051986, 4039.6768258539246, 4042.7170098093147, 111997.88002120037, 115391.0, 115947.42026289814, 116215.0, 121347.393263034, 11026.834597481044, 11048.889511104946, 11098.0, 11176.720581985515, 11204.047655949173, 22203.0, 22855.428614284443, 22900.770992290196, 22920.08319667228, 22930.0, 8038.115807261197, 8126.715564955198, 8222.794430139294, 8244.0, 8338.416310858182, 4554.544545545486, 4608.5621865922685, 4637.049404871993, 4677.672562920563, 4774.570288674036, 3632.5651367709606, 3719.9814000929823, 3748.0629842539365, 3750.8124593770203, 3754.2303827715255, 637.9521535884735, 649.2663290481726, 656.9934300657028, 668.4852663449117, 670.2426258328155, 521.4472658981492, 671.5769065488711, 675.7128220506265, 686.629220221085, 703.3704834173386, 7532.510386824839, 7630.618469076524, 8010.759677209693, 8319.542425166674, 9580.37727547721, 628.3182746719768, 639.1531221132019, 656.6552559906088, 691.8305015271291, 706.9575825450489, 4744.383230180124, 4793.712377257376, 4809.374781278411, 4825.083234185494, 4832.4684284728655, 144512.27743861423, 153855.23072384566, 155238.67141992878, 156635.0, 160462.0, 83338.74991875127, 105950.4702476498, 128417.0, 129082.0, 131983.0, 101989.0, 106299.46850265854, 106370.0, 106835.0, 106917.46541267243, 7154.821129471805, 8492.575371231538, 9081.395291165012, 9103.635854565744, 9184.265258779147, 56081.439185609255, 65249.67375163094, 66320.0, 66364.6681766588, 66628.66742665216, 96304.0, 99898.0, 99925.50037249767, 100022.0, 101402.42286674304, 11293.265937714023, 11631.53473861036, 11888.821667675165, 11953.342566158944, 12021.0, 13614.319284035957, 13638.0, 13747.518836840663, 13960.092593981359, 13969.0, 10441.791164176522, 13104.606861794162, 13118.934405327913, 13166.868331316564, 13167.407466664215, 12048.638540843789, 12568.685782855502, 12962.481500740241, 12970.286634235208, 12972.0, 11962.58130965412, 12404.937975310066, 12426.81359779586, 12451.626451206479, 12843.550475733304, 10682.359058456517, 10856.945715271373, 10889.673309800719, 11128.610498632508, 11411.288306754053, 10764.730881727706, 10918.617848375268, 10933.289336193122, 10963.232573719763, 10989.395583242998], "value": 7880.820953220181, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 108.0, 128.0, 144.0, 164.0, 160.0, 139.0, 114.0, 118.0], "value": 129.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 104.0, 161.0, 182.0, 120.0, 151.0, 158.0, 96.0, 188.0, 141.0], "value": 144.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [228.0, 204.0, 197.0, 259.0, 256.0, 200.0, 211.0, 274.0, 185.0, 185.0], "value": 219.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 90.0, 103.0, 147.0, 75.0, 71.0, 57.0, 74.0, 151.0, 80.0], "value": 91.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 157.0, 99.0, 73.0, 74.0, 110.0, 70.0, 71.0, 124.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 83.0, 101.0, 133.0, 97.0, 131.0, 82.0, 134.0, 130.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 130.0, 104.0, 98.0, 133.0, 150.0, 98.0, 99.0, 97.0, 103.0], "value": 115.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 90.0, 90.0, 93.0, 93.0, 87.0, 89.0, 95.0, 92.0, 91.0], "value": 90.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 56.0, 56.0, 59.0, 59.0, 51.0, 61.0, 63.0, 87.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 68.0, 75.0, 72.0, 73.0, 77.0, 68.0, 68.0, 71.0], "value": 71.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 87.0, 85.0, 84.0, 98.0, 110.0, 98.0, 106.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 148.0, 154.0, 133.0, 137.0, 137.0, 135.0, 141.0, 175.0, 140.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 172.0, 167.0, 166.0, 164.0, 164.0, 166.0, 161.0, 164.0, 156.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 67.0, 66.0, 67.0, 68.0, 70.0, 64.0, 66.0, 67.0], "value": 67.3, "unit": "score"}]}]} 09:21:15 INFO - Return code: 0 09:21:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:21:15 ERROR - # TBPL SUCCESS # 09:21:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:15 INFO - 2016-07-08 09:21:15.925 screenresolution[1674:10795] starting screenresolution argv=screenresolution get 09:21:15 INFO - 2016-07-08 09:21:15.927 screenresolution[1674:10795] Display 0: 1600x1200x32@60 09:21:15 INFO - 2016-07-08 09:21:15.933 screenresolution[1675:10798] starting screenresolution argv=screenresolution list 09:21:15 INFO - Available Modes on Display 0 09:21:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:16 INFO - Intel Iris: 09:21:16 INFO - Chipset Model: Intel Iris 09:21:16 INFO - Type: GPU 09:21:16 INFO - Bus: Built-In 09:21:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:16 INFO - Vendor: Intel (0x8086) 09:21:16 INFO - Device ID: 0x0a2e 09:21:16 INFO - Revision ID: 0x0009 09:21:16 INFO - Displays: 09:21:16 INFO - Display: 09:21:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:16 INFO - Display Serial Number: 1600x1200 60 09:21:16 INFO - Main Display: Yes 09:21:16 INFO - Mirror: Off 09:21:16 INFO - Online: Yes 09:21:16 INFO - Rotation: Supported 09:21:16 INFO - Return code: 0 09:21:16 INFO - Running post-action listener: _resource_record_post_action 09:21:16 INFO - ##### 09:21:16 INFO - ##### Finished run-tests step (success) 09:21:16 INFO - ##### 09:21:16 INFO - Running post-run listener: _resource_record_post_run 09:21:16 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 31596032; Write bytes: 705006080; Read time: 195; Write time: 2018 09:21:16 INFO - TinderboxPrint: CPU usage
54.3% 09:21:16 INFO - TinderboxPrint: I/O read bytes / time
31,596,032 / 195 09:21:16 INFO - TinderboxPrint: I/O write bytes / time
705,006,080 / 2,018 09:21:16 INFO - TinderboxPrint: CPU idle
2,207.2 (45.7%) 09:21:16 INFO - TinderboxPrint: CPU system
972.4 (20.1%) 09:21:16 INFO - TinderboxPrint: CPU user
1,654.1 (34.2%) 09:21:16 INFO - TinderboxPrint: Swap in / out
434,819,072 / 0 09:21:16 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 407872000; Write bytes: 408798720; Read time: 30795; Write time: 909 09:21:16 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29179392; Write bytes: 293142016; Read time: 171; Write time: 1097 09:21:16 INFO - Running post-run listener: _upload_blobber_files 09:21:16 INFO - Blob upload gear active. 09:21:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:21:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:21:16 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'] 09:21:16 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 09:21:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:21:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:21:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:21:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:18 INFO - (blobuploader) - INFO - Done attempting. 09:21:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:21:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:19 INFO - (blobuploader) - INFO - Done attempting. 09:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:21:21 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:21:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:21:21 INFO - (blobuploader) - INFO - Done attempting. 09:21:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:21:21 INFO - Return code: 0 09:21:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:21:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:21:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/35c8aeda4b0b3c05720a19013988b435a5b1aafc2f3affa240f675b230914ab30f10e083a26c3eab426c2a933f5f9b34f748789167f6dffdbd2087d183013832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4710baf08946ff67d0b5bbbfdce6e2d7a5d935fcbb1d9a450decb1c2c37c9a3840c8574b06c8be17fae0fafa2bdf00119546d63a9a8c0541e7ebf970fca0af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fbf67f7154b5a6d07831f0622fd7166137ef80dcec23619a92a2ad690ca3620d878e96904ad162cb18278ab1d932a750bb64b1c130c95121d8df0f3e1f3eb6a"} 09:21:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:21:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:21:21 INFO - Contents: 09:21:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/35c8aeda4b0b3c05720a19013988b435a5b1aafc2f3affa240f675b230914ab30f10e083a26c3eab426c2a933f5f9b34f748789167f6dffdbd2087d183013832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4710baf08946ff67d0b5bbbfdce6e2d7a5d935fcbb1d9a450decb1c2c37c9a3840c8574b06c8be17fae0fafa2bdf00119546d63a9a8c0541e7ebf970fca0af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fbf67f7154b5a6d07831f0622fd7166137ef80dcec23619a92a2ad690ca3620d878e96904ad162cb18278ab1d932a750bb64b1c130c95121d8df0f3e1f3eb6a"} 09:21:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:21:21 INFO - Copying logs to upload dir... 09:21:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:21:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1339.798952 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 19 secs) (at 2016-07-08 09:21:21.522880) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 09:21:21.526224) ========= 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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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/35c8aeda4b0b3c05720a19013988b435a5b1aafc2f3affa240f675b230914ab30f10e083a26c3eab426c2a933f5f9b34f748789167f6dffdbd2087d183013832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4710baf08946ff67d0b5bbbfdce6e2d7a5d935fcbb1d9a450decb1c2c37c9a3840c8574b06c8be17fae0fafa2bdf00119546d63a9a8c0541e7ebf970fca0af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fbf67f7154b5a6d07831f0622fd7166137ef80dcec23619a92a2ad690ca3620d878e96904ad162cb18278ab1d932a750bb64b1c130c95121d8df0f3e1f3eb6a"} build_url:https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010978 build_url: 'https://queue.taskcluster.net/v1/task/e8XAbVYlQEKamGr3HoN8fw/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/35c8aeda4b0b3c05720a19013988b435a5b1aafc2f3affa240f675b230914ab30f10e083a26c3eab426c2a933f5f9b34f748789167f6dffdbd2087d183013832", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/a4710baf08946ff67d0b5bbbfdce6e2d7a5d935fcbb1d9a450decb1c2c37c9a3840c8574b06c8be17fae0fafa2bdf00119546d63a9a8c0541e7ebf970fca0af1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4fbf67f7154b5a6d07831f0622fd7166137ef80dcec23619a92a2ad690ca3620d878e96904ad162cb18278ab1d932a750bb64b1c130c95121d8df0f3e1f3eb6a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 09:21:21.558823) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:21:21.559214) ========= 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.wTyJWGwxf4/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.8qgOe0nZvT/Listeners TMPDIR=/var/folders/4j/mnc9qf551_bgstm4l6ck0qh400000w/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.005033 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 09:21:21.609439) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 09:21:21.609891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 09:21:21.610342) ========= ========= Total master_lag: 0.18 =========