builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0241 starttime: 1467417178.66 results: success (0) buildid: 20160701145923 builduid: fb3d8de2a63d4f57b660eb50addd8227 revision: 3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:58.657958) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:58.658435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:58.658761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:58.718223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:58.718543) ========= 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.RxFMBeED4x/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.FfDxharPFp/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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-01 16:52:58-- 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.5M=0.001s 2016-07-01 16:52:59 (18.5 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.542149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:59.282684) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:59.283006) ========= 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.RxFMBeED4x/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.FfDxharPFp/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.025742 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 16:52:59.331675) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-01 16:52:59.332038) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13 --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 3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RxFMBeED4x/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.FfDxharPFp/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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-01 16:52:59,413 truncating revision to first 12 chars 2016-07-01 16:52:59,414 Setting DEBUG logging. 2016-07-01 16:52:59,414 attempt 1/10 2016-07-01 16:52:59,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3dcecf06e37b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 16:53:00,877 unpacking tar archive at: autoland-3dcecf06e37b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.744044 ========= master_lag: 1.53 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-01 16:53:02.607995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 16:53:02.608260) ========= script_repo_revision: 3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 16:53:02.608622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 16:53:02.608912) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 16:53:02.644054) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-01 16:53:02.644343) ========= /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.RxFMBeED4x/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.FfDxharPFp/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:53:02 INFO - MultiFileLogger online at 20160701 16:53:02 in /builds/slave/test 16:53:02 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 16:53:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:02 INFO - {'append_to_log': False, 16:53:02 INFO - 'base_work_dir': '/builds/slave/test', 16:53:02 INFO - 'blob_upload_branch': 'Autoland', 16:53:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:02 INFO - 'branch': 'Autoland', 16:53:02 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:02 INFO - 'config_files': ('talos/mac_config.py',), 16:53:02 INFO - 'default_actions': ('clobber', 16:53:02 INFO - 'read-buildbot-config', 16:53:02 INFO - 'download-and-extract', 16:53:02 INFO - 'populate-webroot', 16:53:02 INFO - 'create-virtualenv', 16:53:02 INFO - 'install', 16:53:02 INFO - 'run-tests'), 16:53:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:02 INFO - 'download_minidump_stackwalk': True, 16:53:02 INFO - 'download_symbols': 'ondemand', 16:53:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:02 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:02 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:02 INFO - 'installer_path': 'installer.exe', 16:53:02 INFO - 'log_level': 'info', 16:53:02 INFO - 'log_name': 'talos', 16:53:02 INFO - 'log_to_console': True, 16:53:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:53:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:53:02 INFO - 'opt_config_files': (), 16:53:02 INFO - 'pip_index': False, 16:53:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:02 INFO - 'cmd': ('bash', 16:53:02 INFO - '-c', 16:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:02 INFO - 'enabled': True, 16:53:02 INFO - 'halt_on_failure': False, 16:53:02 INFO - 'name': 'check_screen_resolution'},), 16:53:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:53:02 INFO - 'cmd': ('bash', 16:53:02 INFO - '-c', 16:53:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:53:02 INFO - 'enabled': True, 16:53:02 INFO - 'halt_on_failure': False, 16:53:02 INFO - 'name': 'check_screen_resolution'},), 16:53:02 INFO - 'run_cmd_checks_enabled': True, 16:53:02 INFO - 'sps_profile': False, 16:53:02 INFO - 'sps_profile_interval': 0, 16:53:02 INFO - 'suite': 'dromaeojs-e10s', 16:53:02 INFO - 'system_bits': '32', 16:53:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:02 INFO - 'title': 't-yosemite-r7-0241', 16:53:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:02 INFO - 'use_talos_json': True, 16:53:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:02 INFO - 'work_dir': 'build'} 16:53:02 INFO - ##### 16:53:02 INFO - ##### Running clobber step. 16:53:02 INFO - ##### 16:53:02 INFO - Running pre-action listener: _resource_record_pre_action 16:53:02 INFO - Running main action method: clobber 16:53:02 INFO - rmtree: /builds/slave/test/build 16:53:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:04 INFO - Running post-action listener: _resource_record_post_action 16:53:04 INFO - ##### 16:53:04 INFO - ##### Finished clobber step (success) 16:53:04 INFO - ##### 16:53:04 INFO - ##### 16:53:04 INFO - ##### Running read-buildbot-config step. 16:53:04 INFO - ##### 16:53:04 INFO - Running pre-action listener: _resource_record_pre_action 16:53:04 INFO - Running main action method: read_buildbot_config 16:53:04 INFO - Using buildbot properties: 16:53:04 INFO - { 16:53:04 INFO - "project": "", 16:53:04 INFO - "product": "firefox", 16:53:04 INFO - "script_repo_revision": "production", 16:53:04 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 16:53:04 INFO - "repository": "", 16:53:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 16:53:04 INFO - "buildid": "20160701145923", 16:53:04 INFO - "pgo_build": "False", 16:53:04 INFO - "basedir": "/builds/slave/test", 16:53:04 INFO - "buildnumber": 10, 16:53:04 INFO - "slavename": "t-yosemite-r7-0241", 16:53:04 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 16:53:04 INFO - "platform": "yosemite_r7", 16:53:04 INFO - "scheduler": "tests-autoland-macosx64-talos", 16:53:04 INFO - "branch": "autoland", 16:53:04 INFO - "repo_path": "integration/autoland", 16:53:04 INFO - "revision": "3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13", 16:53:04 INFO - "stage_platform": "macosx64", 16:53:04 INFO - "builduid": "fb3d8de2a63d4f57b660eb50addd8227", 16:53:04 INFO - "slavebuilddir": "test" 16:53:04 INFO - } 16:53:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:53:04 INFO - Running post-action listener: _resource_record_post_action 16:53:04 INFO - ##### 16:53:04 INFO - ##### Finished read-buildbot-config step (success) 16:53:04 INFO - ##### 16:53:04 INFO - ##### 16:53:04 INFO - ##### Running download-and-extract step. 16:53:04 INFO - ##### 16:53:04 INFO - Running pre-action listener: _resource_record_pre_action 16:53:04 INFO - Running main action method: download_and_extract 16:53:04 INFO - mkdir: /builds/slave/test/build/tests 16:53:04 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')]} 16:53:04 INFO - https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:53:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:53:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:53:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:53:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:53:35 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 16:53:35 INFO - retry: attempt #1 caught exception: timed out 16:53:35 INFO - retry: Failed, sleeping 30 seconds before retrying 16:54:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:06 INFO - Downloaded 1199 bytes. 16:54:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:54:06 INFO - Using the following test package requirements: 16:54:06 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:54:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:54:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:54:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'jsshell-mac.zip'], 16:54:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:54:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:54:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:54:06 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:54:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:54:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:54:06 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:54:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:54: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')]} 16:54:06 INFO - https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:54:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:54:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:54:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:08 INFO - Downloaded 18789528 bytes. 16:54:08 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'] 16:54:08 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 16:54:11 INFO - Return code: 0 16:54:11 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 16:54:11 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')]} 16:54:11 INFO - https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:54:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:54:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:54:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:17 INFO - Downloaded 18789528 bytes. 16:54:17 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'] 16:54:17 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 16:54:20 INFO - Return code: 0 16:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:20 INFO - https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:54:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:54:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:54:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:22 INFO - Downloaded 14405242 bytes. 16:54:22 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'] 16:54:22 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 16:54:22 INFO - Return code: 0 16:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:22 INFO - https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:54:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:54:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:54:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:54:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CiyjT4o9Qxat62sWgG4vRA/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 16:54:25 INFO - Downloaded 112395969 bytes. 16:54:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:54:25 INFO - mkdir: /builds/slave/test/properties 16:54:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:25 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:25 INFO - Contents: 16:54:25 INFO - build_url:https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:54:26 INFO - Running post-action listener: _resource_record_post_action 16:54:26 INFO - Running post-action listener: set_extra_try_arguments 16:54:26 INFO - ##### 16:54:26 INFO - ##### Finished download-and-extract step (success) 16:54:26 INFO - ##### 16:54:26 INFO - ##### 16:54:26 INFO - ##### Running populate-webroot step. 16:54:26 INFO - ##### 16:54:26 INFO - Running pre-action listener: _resource_record_pre_action 16:54:26 INFO - Running main action method: populate_webroot 16:54:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:26 INFO - '--tppagecycles', 16:54:26 INFO - '7'], 16:54:26 INFO - 'tests': ['tsvgm']}}, 16:54:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['damp', 'tps']}, 16:54:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'tests': ['damp', 'tps']}, 16:54:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['dromaeo_dom']}, 16:54:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['basic_compositor_video']}, 16:54:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:54:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['a11yr', 16:54:26 INFO - 'ts_paint', 16:54:26 INFO - 'tpaint', 16:54:26 INFO - 'sessionrestore', 16:54:26 INFO - 'sessionrestore_no_auto_restore', 16:54:26 INFO - 'tabpaint']}, 16:54:26 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:26 INFO - 'ts_paint', 16:54:26 INFO - 'tpaint', 16:54:26 INFO - 'sessionrestore', 16:54:26 INFO - 'sessionrestore_no_auto_restore', 16:54:26 INFO - 'tabpaint']}, 16:54:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:26 INFO - 'ts_paint', 16:54:26 INFO - 'tpaint', 16:54:26 INFO - 'sessionrestore', 16:54:26 INFO - 'sessionrestore_no_auto_restore', 16:54:26 INFO - 'tabpaint']}, 16:54:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:26 INFO - 'ts_paint', 16:54:26 INFO - 'tpaint', 16:54:26 INFO - 'sessionrestore', 16:54:26 INFO - 'sessionrestore_no_auto_restore', 16:54:26 INFO - 'tabpaint']}, 16:54:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['a11yr', 16:54:26 INFO - 'ts_paint', 16:54:26 INFO - 'tpaint', 16:54:26 INFO - 'sessionrestore', 16:54:26 INFO - 'sessionrestore_no_auto_restore', 16:54:26 INFO - 'tabpaint']}, 16:54:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['a11yr', 16:54:26 INFO - 'ts_paint', 16:54:26 INFO - 'tpaint', 16:54:26 INFO - 'sessionrestore', 16:54:26 INFO - 'sessionrestore_no_auto_restore', 16:54:26 INFO - 'tabpaint']}, 16:54:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['tsvgx', 16:54:26 INFO - 'tsvgr_opacity', 16:54:26 INFO - 'tart', 16:54:26 INFO - 'tscrollx', 16:54:26 INFO - 'cart']}, 16:54:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:26 INFO - 'tsvgr_opacity', 16:54:26 INFO - 'tart', 16:54:26 INFO - 'tscrollx', 16:54:26 INFO - 'cart']}, 16:54:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'talos_options': ['--disable-e10s'], 16:54:26 INFO - 'tests': ['tp5o']}, 16:54:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'tests': ['tp5o']}, 16:54:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'talos_options': ['--disable-e10s', 16:54:26 INFO - '--xperf_path', 16:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:26 INFO - 'tests': ['tp5n']}, 16:54:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:26 INFO - 'talos_options': ['--xperf_path', 16:54:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:26 INFO - 'tests': ['tp5n']}}, 16:54:26 INFO - 'talos.zip': {'path': '', 16:54:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:26 INFO - Running post-action listener: _resource_record_post_action 16:54:26 INFO - ##### 16:54:26 INFO - ##### Finished populate-webroot step (success) 16:54:26 INFO - ##### 16:54:26 INFO - ##### 16:54:26 INFO - ##### Running create-virtualenv step. 16:54:26 INFO - ##### 16:54:26 INFO - Running pre-action listener: _resource_record_pre_action 16:54:26 INFO - Running main action method: create_virtualenv 16:54:26 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:26 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 16:54:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:26 INFO - Using real prefix '/tools/python27' 16:54:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:27 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:30 INFO - Installing pip.................done. 16:54:30 INFO - Return code: 0 16:54:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:30 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:30 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 16:54:30 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 16:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:30 INFO - 'HOME': '/Users/cltbld', 16:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:30 INFO - 'LOGNAME': 'cltbld', 16:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:30 INFO - 'MOZ_NO_REMOTE': '1', 16:54:30 INFO - 'NO_EM_RESTART': '1', 16:54:30 INFO - 'PAGER': '/bin/cat', 16:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:30 INFO - 'PWD': '/builds/slave/test', 16:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:30 INFO - 'SHELL': '/bin/bash', 16:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:30 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:30 INFO - 'USER': 'cltbld', 16:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:30 INFO - 'XPC_FLAGS': '0x0', 16:54:30 INFO - 'XPC_SERVICE_NAME': '0', 16:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:30 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 16:54:30 INFO - Cleaning up... 16:54:30 INFO - Return code: 0 16:54:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:30 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:30 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 16:54:30 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 16:54:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:30 INFO - 'HOME': '/Users/cltbld', 16:54:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:30 INFO - 'LOGNAME': 'cltbld', 16:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:30 INFO - 'MOZ_NO_REMOTE': '1', 16:54:30 INFO - 'NO_EM_RESTART': '1', 16:54:30 INFO - 'PAGER': '/bin/cat', 16:54:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:30 INFO - 'PWD': '/builds/slave/test', 16:54:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:30 INFO - 'SHELL': '/bin/bash', 16:54:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:30 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:30 INFO - 'USER': 'cltbld', 16:54:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:30 INFO - 'XPC_FLAGS': '0x0', 16:54:30 INFO - 'XPC_SERVICE_NAME': '0', 16:54:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:30 INFO - Downloading/unpacking psutil>=3.1.1 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 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 16:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:33 INFO - Installing collected packages: psutil 16:54:33 INFO - Running setup.py install for psutil 16:54:33 INFO - building 'psutil._psutil_osx' extension 16:54:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:54:33 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:54:34 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 16:54:34 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 16:54:34 INFO - building 'psutil._psutil_posix' extension 16:54:34 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 16:54:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:54:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:54:34 INFO - ^ 16:54:34 INFO - 1 warning generated. 16:54:34 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 16:54:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:34 INFO - Successfully installed psutil 16:54:34 INFO - Cleaning up... 16:54:34 INFO - Return code: 0 16:54:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:34 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:34 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 16:54:34 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 16:54:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:34 INFO - 'HOME': '/Users/cltbld', 16:54:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:34 INFO - 'LOGNAME': 'cltbld', 16:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:34 INFO - 'MOZ_NO_REMOTE': '1', 16:54:34 INFO - 'NO_EM_RESTART': '1', 16:54:34 INFO - 'PAGER': '/bin/cat', 16:54:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:34 INFO - 'PWD': '/builds/slave/test', 16:54:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:34 INFO - 'SHELL': '/bin/bash', 16:54:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:34 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:34 INFO - 'USER': 'cltbld', 16:54:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:34 INFO - 'XPC_FLAGS': '0x0', 16:54:34 INFO - 'XPC_SERVICE_NAME': '0', 16:54:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:37 INFO - Installing collected packages: mozsystemmonitor 16:54:37 INFO - Running setup.py install for mozsystemmonitor 16:54:37 INFO - Successfully installed mozsystemmonitor 16:54:37 INFO - Cleaning up... 16:54:37 INFO - Return code: 0 16:54:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54:37 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')]} 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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')]} 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:37 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 16:54:37 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 16:54:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:37 INFO - 'HOME': '/Users/cltbld', 16:54:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:37 INFO - 'LOGNAME': 'cltbld', 16:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:37 INFO - 'MOZ_NO_REMOTE': '1', 16:54:37 INFO - 'NO_EM_RESTART': '1', 16:54:37 INFO - 'PAGER': '/bin/cat', 16:54:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:37 INFO - 'PWD': '/builds/slave/test', 16:54:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:37 INFO - 'SHELL': '/bin/bash', 16:54:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:37 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:37 INFO - 'USER': 'cltbld', 16:54:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:37 INFO - 'XPC_FLAGS': '0x0', 16:54:37 INFO - 'XPC_SERVICE_NAME': '0', 16:54:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:37 INFO - Downloading/unpacking jsonschema==2.5.1 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54: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 16:54:40 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:40 INFO - warning: no files found matching '*.txt' 16:54:40 INFO - no previously-included directories found matching 'build' 16:54:40 INFO - no previously-included directories found matching 'dist' 16:54:40 INFO - no previously-included directories found matching '.git*' 16:54:40 INFO - Installing collected packages: jsonschema, functools32 16:54:40 INFO - Running setup.py install for functools32 16:54:40 INFO - warning: no files found matching '*.txt' 16:54:40 INFO - no previously-included directories found matching 'build' 16:54:40 INFO - no previously-included directories found matching 'dist' 16:54:40 INFO - no previously-included directories found matching '.git*' 16:54:40 INFO - Successfully installed jsonschema functools32 16:54:40 INFO - Cleaning up... 16:54:40 INFO - Return code: 0 16:54:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:54:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:54:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:40 INFO - 'HOME': '/Users/cltbld', 16:54:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:40 INFO - 'LOGNAME': 'cltbld', 16:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:40 INFO - 'MOZ_NO_REMOTE': '1', 16:54:40 INFO - 'NO_EM_RESTART': '1', 16:54:40 INFO - 'PAGER': '/bin/cat', 16:54:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:40 INFO - 'PWD': '/builds/slave/test', 16:54:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:40 INFO - 'SHELL': '/bin/bash', 16:54:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:40 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:40 INFO - 'USER': 'cltbld', 16:54:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:40 INFO - 'XPC_FLAGS': '0x0', 16:54:40 INFO - 'XPC_SERVICE_NAME': '0', 16:54:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:41 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:41 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 16:54:41 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 16:54:41 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 16:54:41 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 16:54:41 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 16:54:41 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 16:54:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54:44 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 16:54:44 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 16:54:44 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 16:54:44 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 16:54:44 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 16:54:44 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 16:54:44 INFO - Downloading docopt-0.6.1.tar.gz 16:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:44 INFO - Running setup.py install for blobuploader 16:54:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:44 INFO - Running setup.py install for requests 16:54:45 INFO - Running setup.py install for docopt 16:54:45 INFO - Successfully installed blobuploader requests docopt 16:54:45 INFO - Cleaning up... 16:54:45 INFO - Return code: 0 16:54:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:54:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:45 INFO - 'HOME': '/Users/cltbld', 16:54:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:45 INFO - 'LOGNAME': 'cltbld', 16:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:45 INFO - 'MOZ_NO_REMOTE': '1', 16:54:45 INFO - 'NO_EM_RESTART': '1', 16:54:45 INFO - 'PAGER': '/bin/cat', 16:54:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:45 INFO - 'PWD': '/builds/slave/test', 16:54:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:45 INFO - 'SHELL': '/bin/bash', 16:54:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:45 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:45 INFO - 'USER': 'cltbld', 16:54:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:45 INFO - 'XPC_FLAGS': '0x0', 16:54:45 INFO - 'XPC_SERVICE_NAME': '0', 16:54:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:45 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-ivEuqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-WVAkS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-eVvgiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-yB4u_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Dz_HwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-SfKQUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-xKzdI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-OXTLbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Pr4nGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:46 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-CRqc9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Fh38hP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Y47Jcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-XjS4Wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-tXZuej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-fAxVmh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-yxqBKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:47 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-dIJzSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:47 INFO - Running setup.py install for manifestparser 16:54:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:47 INFO - Running setup.py install for mozcrash 16:54:48 INFO - Running setup.py install for mozdebug 16:54:48 INFO - Running setup.py install for mozdevice 16:54:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Running setup.py install for mozfile 16:54:48 INFO - Running setup.py install for mozhttpd 16:54:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Running setup.py install for mozinfo 16:54:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Running setup.py install for mozInstall 16:54:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:48 INFO - Running setup.py install for mozleak 16:54:49 INFO - Running setup.py install for mozlog 16:54:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:49 INFO - Running setup.py install for moznetwork 16:54:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:49 INFO - Running setup.py install for mozprocess 16:54:49 INFO - Running setup.py install for mozprofile 16:54:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:49 INFO - Running setup.py install for mozrunner 16:54:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:49 INFO - Running setup.py install for mozscreenshot 16:54:49 INFO - Running setup.py install for moztest 16:54:50 INFO - Running setup.py install for mozversion 16:54:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:50 INFO - Cleaning up... 16:54:50 INFO - Return code: 0 16:54:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:50 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:50 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 16:54:50 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 16:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:50 INFO - 'HOME': '/Users/cltbld', 16:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:50 INFO - 'LOGNAME': 'cltbld', 16:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:50 INFO - 'MOZ_NO_REMOTE': '1', 16:54:50 INFO - 'NO_EM_RESTART': '1', 16:54:50 INFO - 'PAGER': '/bin/cat', 16:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:50 INFO - 'PWD': '/builds/slave/test', 16:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:50 INFO - 'SHELL': '/bin/bash', 16:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:50 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:50 INFO - 'USER': 'cltbld', 16:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:50 INFO - 'XPC_FLAGS': '0x0', 16:54:50 INFO - 'XPC_SERVICE_NAME': '0', 16:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-LlPxSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:50 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)) 16:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-tX5pkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-lK4QBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-KzdOv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:50 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-N_73m6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:51 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)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-7Nn6gf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:51 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)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-6rDgUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:51 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)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-0oBWXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:51 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)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-iPHo3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:51 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)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-8w0f1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:51 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)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-1EBkD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-IfRsSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-Z2Bbqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:51 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-q6IM2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-23_6Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:52 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)) 16:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-zS3AFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:52 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)) 16:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:52 INFO - Running setup.py (path:/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/pip-JmKZXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:52 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)) 16:54:52 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)) 16:54:52 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)) 16:54:52 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)) 16:54:52 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)) 16:54:52 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)) 16:54:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:52 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 16:54:52 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 16:54:52 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 16:54:52 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 16:54:52 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 16:54:52 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 16:54:54 INFO - Downloading blessings-1.6.tar.gz 16:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:54 INFO - Installing collected packages: blessings 16:54:54 INFO - Running setup.py install for blessings 16:54:55 INFO - Successfully installed blessings 16:54:55 INFO - Cleaning up... 16:54:55 INFO - Return code: 0 16:54:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:55 INFO - Reading from file tmpfile_stdout 16:54:55 INFO - Current package versions: 16:54:55 INFO - blessings == 1.6 16:54:55 INFO - blobuploader == 1.2.4 16:54:55 INFO - docopt == 0.6.1 16:54:55 INFO - functools32 == 3.2.3-2 16:54:55 INFO - jsonschema == 2.5.1 16:54:55 INFO - manifestparser == 1.1 16:54:55 INFO - mozInstall == 1.12 16:54:55 INFO - mozcrash == 0.17 16:54:55 INFO - mozdebug == 0.1 16:54:55 INFO - mozdevice == 0.48 16:54:55 INFO - mozfile == 1.2 16:54:55 INFO - mozhttpd == 0.7 16:54:55 INFO - mozinfo == 0.9 16:54:55 INFO - mozleak == 0.1 16:54:55 INFO - mozlog == 3.2 16:54:55 INFO - moznetwork == 0.27 16:54:55 INFO - mozprocess == 0.22 16:54:55 INFO - mozprofile == 0.28 16:54:55 INFO - mozrunner == 6.11 16:54:55 INFO - mozscreenshot == 0.1 16:54:55 INFO - mozsystemmonitor == 0.3 16:54:55 INFO - moztest == 0.7 16:54:55 INFO - mozversion == 1.4 16:54:55 INFO - psutil == 3.1.1 16:54:55 INFO - requests == 1.2.3 16:54:55 INFO - wsgiref == 0.1.2 16:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:55 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')]} 16:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:55 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')]} 16:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:55 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:55 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 16:54:55 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 16:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:55 INFO - 'HOME': '/Users/cltbld', 16:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:55 INFO - 'LOGNAME': 'cltbld', 16:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:55 INFO - 'MOZ_NO_REMOTE': '1', 16:54:55 INFO - 'NO_EM_RESTART': '1', 16:54:55 INFO - 'PAGER': '/bin/cat', 16:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:55 INFO - 'PWD': '/builds/slave/test', 16:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:55 INFO - 'SHELL': '/bin/bash', 16:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:55 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:55 INFO - 'USER': 'cltbld', 16:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:55 INFO - 'XPC_FLAGS': '0x0', 16:54:55 INFO - 'XPC_SERVICE_NAME': '0', 16:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 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)) 16:54:55 INFO - Cleaning up... 16:54:55 INFO - Return code: 0 16:54:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54:55 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')]} 16:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:55 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')]} 16:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:55 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 0x108e0ca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ea1618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6a8dba060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, '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.RxFMBeED4x/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.FfDxharPFp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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 16:54:55 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 16:54:55 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 16:54:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:54:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:54:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:54:55 INFO - 'HOME': '/Users/cltbld', 16:54:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:54:55 INFO - 'LOGNAME': 'cltbld', 16:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:55 INFO - 'MOZ_NO_REMOTE': '1', 16:54:55 INFO - 'NO_EM_RESTART': '1', 16:54:55 INFO - 'PAGER': '/bin/cat', 16:54:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:55 INFO - 'PWD': '/builds/slave/test', 16:54:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:54:55 INFO - 'SHELL': '/bin/bash', 16:54:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:54:55 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:54:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:54:55 INFO - 'USER': 'cltbld', 16:54:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:54:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:55 INFO - 'XPC_FLAGS': '0x0', 16:54:55 INFO - 'XPC_SERVICE_NAME': '0', 16:54:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:54:55 INFO - Cleaning up... 16:54:56 INFO - Return code: 0 16:54:56 INFO - Running post-action listener: _resource_record_post_action 16:54:56 INFO - Running post-action listener: _start_resource_monitoring 16:54:56 INFO - Starting resource monitoring. 16:54:56 INFO - ##### 16:54:56 INFO - ##### Finished create-virtualenv step (success) 16:54:56 INFO - ##### 16:54:56 INFO - ##### 16:54:56 INFO - ##### Running install step. 16:54:56 INFO - ##### 16:54:56 INFO - Running pre-action listener: _resource_record_pre_action 16:54:56 INFO - Running main action method: install 16:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:56 INFO - Reading from file tmpfile_stdout 16:54:56 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:56 INFO - Reading from file tmpfile_stdout 16:54:56 INFO - Output received: 16:54:56 INFO - Usage: mozinstall [options] installer 16:54:56 INFO - Options: 16:54:56 INFO - -h, --help show this help message and exit 16:54:56 INFO - -d DEST, --destination=DEST 16:54:56 INFO - Directory to install application into. [default: 16:54:56 INFO - "/builds/slave/test"] 16:54:56 INFO - --app=APP Application being installed. [default: firefox] 16:54:56 INFO - mkdir: /builds/slave/test/build/application 16:54:56 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'] 16:54:56 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 16:55:30 INFO - Reading from file tmpfile_stdout 16:55:30 INFO - Output received: 16:55:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:55:30 INFO - Running post-action listener: _resource_record_post_action 16:55:30 INFO - ##### 16:55:30 INFO - ##### Finished install step (success) 16:55:30 INFO - ##### 16:55:30 INFO - ##### 16:55:30 INFO - ##### Running run-tests step. 16:55:30 INFO - ##### 16:55:30 INFO - Running pre-action listener: _resource_record_pre_action 16:55:30 INFO - Running main action method: run_tests 16:55:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:55:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:55:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:55:30 INFO - 2016-07-01 16:55:30.551 screenresolution[1648:8135] starting screenresolution argv=screenresolution get 16:55:30 INFO - 2016-07-01 16:55:30.554 screenresolution[1648:8135] Display 0: 1600x1200x32@60 16:55:30 INFO - 2016-07-01 16:55:30.560 screenresolution[1649:8137] starting screenresolution argv=screenresolution list 16:55:30 INFO - Available Modes on Display 0 16:55:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:55:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:55:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:55:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:55:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:55:30 INFO - Intel Iris: 16:55:30 INFO - Chipset Model: Intel Iris 16:55:30 INFO - Type: GPU 16:55:30 INFO - Bus: Built-In 16:55:30 INFO - VRAM (Dynamic, Max): 1536 MB 16:55:30 INFO - Vendor: Intel (0x8086) 16:55:30 INFO - Device ID: 0x0a2e 16:55:30 INFO - Revision ID: 0x0009 16:55:30 INFO - Displays: 16:55:30 INFO - Display: 16:55:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:55:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:55:30 INFO - Display Serial Number: 1600x1200 60 16:55:30 INFO - Main Display: Yes 16:55:30 INFO - Mirror: Off 16:55:30 INFO - Online: Yes 16:55:30 INFO - Rotation: Supported 16:55:30 INFO - Return code: 0 16:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:30 INFO - Python 2.7.3 16:55:30 INFO - Return code: 0 16:55:30 INFO - grabbing minidump binary from tooltool 16:55: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')]} 16:55:30 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d70d30>, '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 0x108ad5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d68b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:55:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:55:30 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:55:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:30 INFO - Return code: 0 16:55:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:55:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:55:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 16:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0241 --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 16:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RxFMBeED4x/Render', 16:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:55:30 INFO - 'HOME': '/Users/cltbld', 16:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:55:30 INFO - 'LOGNAME': 'cltbld', 16:55:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:30 INFO - 'MOZ_NO_REMOTE': '1', 16:55:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:30 INFO - 'NO_EM_RESTART': '1', 16:55:30 INFO - 'PAGER': '/bin/cat', 16:55:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:30 INFO - 'PWD': '/builds/slave/test', 16:55:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:55:30 INFO - 'SHELL': '/bin/bash', 16:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.FfDxharPFp/Listeners', 16:55:30 INFO - 'TMPDIR': '/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/', 16:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:55:30 INFO - 'USER': 'cltbld', 16:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:30 INFO - 'XPC_FLAGS': '0x0', 16:55:30 INFO - 'XPC_SERVICE_NAME': '0', 16:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:55:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0241', '--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 16:55:31 INFO - mozversion application_buildid: 20160701145923 16:55:31 INFO - mozversion application_changeset: 3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13 16:55:31 INFO - mozversion application_display_name: Nightly 16:55:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:31 INFO - mozversion application_name: Firefox 16:55:31 INFO - mozversion application_remotingname: firefox 16:55:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:55:31 INFO - mozversion application_vendor: Mozilla 16:55:31 INFO - mozversion application_version: 50.0a1 16:55:31 INFO - mozversion platform_buildid: 20160701145923 16:55:31 INFO - mozversion platform_changeset: 3dcecf06e37b403d3c8a518b6848fbcf5e3c8c13 16:55:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:55:31 INFO - mozversion platform_version: 50.0a1 16:55:31 INFO - using testdate: 1467417331 16:55:31 INFO - actual date: 1467417331 16:55:31 INFO - starting webserver on 'localhost:49273' 16:55:31 INFO - SUITE-START | Running 2 tests 16:55:31 INFO - TEST-START | dromaeo_css 16:55:31 INFO - operating with platform_type : mac_ 16:55:31 INFO - Initialising browser for dromaeo_css test... 16:55:31 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpwa902g/profile http://localhost:49273/getInfo.html) 16:55:34 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 16:55:34 INFO - PROCESS | 1659 | colorDepth:24 16:55:34 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 16:55:34 INFO - PROCESS | 1659 | __metrics 16:55:34 ERROR - PROCESS | 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:55:34 INFO - TEST-INFO | 1659: exit 0 16:55:34 INFO - Browser initialized. 16:55:34 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:34 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpwa902g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:46 INFO - PROCESS | 1663 | RSS: Main: 255586304 16:55:46 INFO - PROCESS | 1663 | 16:56:36 INFO - PROCESS | 1663 | 1467417396338 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] 16:58:47 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 16:58:49 INFO - PROCESS | 1663 | RSS: Main: 268259328 16:58:49 INFO - PROCESS | 1663 | 17:01:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 17:01:51 INFO - PROCESS | 1663 | RSS: Main: 276676608 17:01:51 INFO - PROCESS | 1663 | 17:04:53 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 17:04:54 INFO - PROCESS | 1663 | RSS: Main: 281214976 17:04:54 INFO - PROCESS | 1663 | 17:07:56 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 17:07:56 INFO - PROCESS | 1663 | RSS: Main: 280190976 17:07:56 INFO - PROCESS | 1663 | 17:10:59 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 17:11:00 INFO - PROCESS | 1663 | RSS: Main: 283832320 17:11:00 INFO - PROCESS | 1663 | 17:14:02 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 17:14:03 INFO - PROCESS | 1663 | RSS: Main: 283889664 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | __start_tp_report 17:14:03 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 17:14:03 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 17:14:03 INFO - PROCESS | 1663 | |i|pagename|runs| 17:14:03 INFO - PROCESS | 1663 | |0;dojo.html;2979.5828583998236;3339.983300083499;3435.5877294724637;3471.44456886898;3497.965020349796;5051.469595692454;5799.9560079185785;5838.941610583893;5870.970645146774;5919.615225010377;5338.172583249593;5517.751701173447;5859.589828711981;5908.556858235639;5996;5289.338832645919;5337.70642614656;5342.439043900393;5445.754941027643;5493.533049690781;4600.263957766758;5463.7814487420455;5516.862078448031;5553.888922221553;5557.360903496109;4451.577100175478;5233.528982391584;5292.153255479105;5316.946830531684;5387.568994480452;5339.946600533984;5354.732263386815;5379.246905433242;5399.973000134974;5434;4335.6965012449145;5348.491893270133;5380;5397.325334333208;5419.5393391561765;4860.878478038042;5811.651300921916;5841.357450680422;5974.6713930733795;5978.133170690269;5197.974010129963;6223.968880155616;6250.843728906768;6259.624422534663;6266.749330026793;6176.660283684396;6187.87624247517;6289;6296.87406251877;6318.684065796738;5013.423456302499;5967.671778052206;6064.575479716422;6069.666168360694;6075.848103797396;4840.491748366441;6080.118382834553;6287.559870808999;6428.453581445536;6501.902471462932;5779.942200578024;5902.793402230901;6181.072839074175;6241.75032998684;6279.152314437584;6254.280757712831;6294.590851594632;6306.24325080984;6325.746970121236;6382.808515744535;6104.913929256131;6142.201513803177;6210.7515699372425;6239.157713708682;6306.65313407767;5117.616178786606;6137.959273351834;6149.754009839557;6194.101855231056;6216.067589861557;5042.42012168598;5088.77100530477;5107.412647545506;5114.795408183705;5143.228515722597;4521.886952826206;4542.227821270392;4554.658400619901;4582.610478109398;4622.699524530962;5832.591718579743;5941.554383421174;5947.86990471809;5992.610480318765;6039.275286965592;5043.924341134886;6181.134641150243;6278.183836101278;6310.274318453345;6406.455451286693;4992.475790042066;5970;5971.552133589998;6034.275886893601;6051.031834906394;5473.67157970523;5512.3385193777;5515.558755299567;5588.636738612058;5616.747246373923;5739;6464.676766161579;6487.610743355225;6496.447801936888;6507.869842603216;6260.186175797117;6264;6274.466670333073;6289.9371006291185;6290.465310448663;6213.440790328892;6344.1118243445035;6370.331115232834;6432.2281326241155;6485.156929599122;6244.219472565929;6257.624542527463;6259.311475737574;6288.182536270256;6291.307956124914;6248.875022499616;6255.218097737783;6255.687215639109;6257.1552840367785;6271.498280137487;6072.180255665428;6103.155845961415;6140.933729672948;6143.139960405458;6163.907541386793;6143.662098584621;6162.691865406622;6204.13142160107;6204.317525072329;6235.282942461675;5106.361704786902;6104.908426373697;6184.907226391698;6186.752529898754;6195.721192546256;6107.310189946737;6114.041198129025;6132.355508992456;6157.876842463036;6225.346338634378;6130.478909292582;6138.662373569497;6150.261968563801;6157.476614487819;6162.352952939877 17:14:03 INFO - PROCESS | 1663 | |1;ext.html;470.7457972694745;477.1601980514292;502.48997267773217;529.1375058654395;570.1248583424444;38234.04414889625;40583.59416405835;40660.39009414861;40871.38692919609;40949;40389.59610403895;40557;40956.18087638245;41023.79488102563;41157.38263926036;9450.621975120986;9465.952670236657;9476.715698529055;9486.905130948706;9535.284853636005;9514.381565198275;9605.327627066108;9649;9649.710508684751;9668.661596844111;9518.381305215173;9596.712098637017;9614.990426005274;9663.806723865553;9663.95168024159;9570.952145239264;9638.807223855518;9652.469114198751;9655.08276713711;9659.758506037335;9612.807743845084;9646.951765241129;9662.661806836726;9665.613375464973;9675.129238368581;38861.41707874384;39089.60910390916;39415;39436.802815986026;39792.60207397947;3317.253617935945;3332.583427071616;3338.666133386642;3362.260302733395;3501.072215862798;30809.537856932166;31888.840555797073;31987.52018719721;32742.34515309704;32995.83502082474;3241.2743557119074;3315.9171020724434;3328.3010567780793;3386.7967921924765;3426.9033909149084;516825;523129;524489;525050;527222;33803;62648.373516264255;62731.37268627347;62986.68506657438;63307;33613.32773344568;33657.49513757246;34743.82628086894;34893.476597851055;34967;12158.331291779037;14431.42274309016;14701.117932924059;14705.926470367795;14731.263436828116;12524.812127817908;12587.37063146839;12590.81113783294;12593;12654.81017784734;6703.765368212089;7547.73582924595;7668.194839541879;7700.614969251515;7760.417968652374;3161.6129821984255;3185.0604071798875;3213.22882508201;3215.5980502437196;3238.951415728766;978.7161723100221;980.7793246519618;981.3375971219398;1059.8659434405113;1107.396468924438;30783;30852.22869428282;30857.919972801294;31197.688023119477;31259.218519537193;1012.696191142669;1028.2699283508794;1112.9165312601588;1133.2124173699365;1158.9420528973517;15741.527754167164;16072.196390180445;16112.355505779871;16160.191990400433;16355.754663680054;708744;725029;728048;729849;731200;55468.44531554633;55861;57790.422095779344;57993.71003144957;58023.70988145117;1378.800073989266;1395.051365071761;1412.2585642537545;1412.3785534364847;1416.5750274917484;29968.400631986802;30122.039481894433;30160.944366947053;30730;30888.536671950387;49469.50530494793;50499.49500504948;50963.98072038464;51135.48864511307;51203.743981279855;602586;627080;627858;627875;628543;26438.471230575666;26634.600480992412;26722.59916101299;26952;27000.32499187536;47164.820879478284;48079.519204807504;48084.393670475554;48533.27200092072;49125.508744913524;39820.60179398169;40060.79969600133;40204.79897600493;40493.1901361977;40795;39655.60344396634;39906.60093399029;40252;40876.79561602173;41820.58179418167;37828.62171378251;38614.2277154461;38885.416718748675;38983.415248770725;39023.414648779726;32269.67730322667;36066;36543.08642283964;36592.26815463623;36819.63180368269;22165.445863853533;25548.872255638602;26052;26138.085167019064;26450.867745661148 17:14:03 INFO - PROCESS | 1663 | |2;jquery.html;343.78985969387753;349.3223147094637;377.11190147203337;393.590665707664;404.7187204892599;19996.800031999675;20098.59802803943;20893.268735594258;21068.157273709054;21074.15703371863;11687.941560292187;12228.266304021743;12251.326177060258;12267;15970;5197.168453047513;5337.839864804062;5366.490183432567;5385.434529374418;5387.676739395629;3879.5538513070933;5747.655140691551;6406.775762848301;6739.966300168492;6804.7278108875835;5737.827865164052;5771.913421298684;6655.168103987002;6730.226024007253;6771.153605799275;6511.967440162793;6620.30486798884;6637.004449332615;6684.16447944007;6697.296783837724;5778.306603207642;5785.739641716091;5855.912161317584;5929.851753706149;5935.525157987394;13320.267385293804;13664.726705465935;13731;20109.29617463382;25461.745382546123;2183.825293976494;2296.1389478945393;2306.238941149417;2543.465872166847;2626.290901456596;10202.183825293958;10207.540660670287;10321.793564128751;10390.324628899172;10691.732706682318;1642.3266460751036;1941.6602094633524;1972.5463143477082;1978.9017095511986;1989.641864464396;120892;123843;124754.37622811919;125404;125599;8833.425827321204;11541.07671386287;11625.2443591168;11699.649010529698;11707.239029463057;13319.40062697181;14428.495002674856;14520.709585808225;14585.562433127023;14670.926645366704;8442.915570844336;8530.616122274512;8566;8616.569171541398;8713.912860871436;8527.062023177445;8535.615897284513;8544.700935467354;8626.094260102724;8633.39566230358;4109.157622687401;4250.702450828474;4431.158079964796;4595.609373203315;4653.068976374767;1827.921223644797;1979.5051237190703;1979.6733538966198;1983.2761042219486;1987.5031242189452;845.3913182508584;886.7871710789364;890.5102193793388;898.3801177187851;945.0832692288469;17962.820371796377;21858.89070554637;21935;21951.01220445084;21982.34052978413;929.5445231836487;949.5299826585884;965.6234068713208;990.9058639429243;993.6869885985891;11494.42527873603;11507.309561426342;11557.248778829517;11588.88411115895;11769.999550038172;614987;622520;622753;622958.3401599717;624070;113922;118146.40926795483;122456;135543;140230;966.3622009473854;975.1321324021626;1009.7122320138872;1016.6136867990116;1019.8929112443235;18921;19178.328758493386;19298;19527.414177574694;19586;55556.444435555124;55994.44005560055;56826.863462729685;56985.43014569967;57203;83375;83636.58181709053;84149;84194.31611367861;84741.15258847333;6929.965350173217;8032.357411407191;8232.62953167097;8290.679179652921;8429.747107586782;12732.363381830686;13147.013973952184;13182.340882956005;13222.008349373644;13301.401436935168;11196.608118716133;11313.547458101913;11400.94299528497;11424.485898134437;11486.966173044466;11108.61119860801;11279.492422841156;11330.206885517935;11335.263207891461;11336.433178340885;11452.82820757706;11486.310821350746;11538.134639901873;11589.956903878692;11713.824292635447;8076.798080048045;8091;8260.008798944165;8275.875861861956;8280;9499.43003419797;11401.315921044765;11419.543218271176;11510;11537.423128843691 17:14:03 INFO - PROCESS | 1663 | |3;mootools.html;1502.8647421732041;1551.3019141386376;1751.562109472631;1863.142954241049;1887.8206570375826;8071.6367763450635;8644.135586441353;8706.825863482727;9215.723528294162;9251.953740231305;8757.91242087579;8763.95618021909;8784.60469278884;8894.021657617657;8921.776955576097;1779.3238569343632;1922.903854807261;2336.19401306549;2337.28712742613;2337.8831058447095;2306.550222706573;2337.1819863047967;2367.5501654685554;2391.868447235401;2399.748026457214;2310.849794763343;2362.7637236276405;2367.573836709392;2376.66726658268;2392.3779817247555;2319.617263151578;2340.204330527629;2370.5851475991717;2370.6799582056374;2379.9762002380016;1993.2226431691506;2295.2884605772097;2351.412146963259;2360.386299562109;2365.31405892291;8088.9595552021865;8705.869411958825;8979.057198994142;9061.818763624691;9078.409903356262;4936.753162341868;5336.092864213093;5398.8920221595745;5410.323709536308;5419.647722898038;3032.848357582112;3596.946045809315;3725.6646901778972;3733.981330093332;3765.2093060457337;1078.040778064212;1097.6158344579333;1107.0755918807806;1127.9436028198638;1128.4808987865592;11711.824322635168;11827.053835693125;11839.348835814028;11847.289162650268;11875.584354547549;4447.466304043535;4683.086798074342;4819.445763737145;4865.026994601023;4875.561199492063;10051.899481005243;10059.346142500714;10070.546825392876;10084.899151008543;10093.293469457067;5358.27663265462;5361.517463428232;5415.729213539386;5424.891502169935;5433.157860531544;4034.838606455709;4436.755978421218;4902.28916807061;4911.607071434277;4962.379702537183;3996.9200615987515;4025.3961905714377;4077.9796101019306;4082.81627326771;4134.214499245134;1299.4542292237284;1308.7644224039575;1316.605018494467;1319.973600527984;1324.6820763016806;821.8068753842842;915.5834095486538;927.3369540778241;936.2463217110292;942.79258563116;6000.249968753906;6027.397260274025;6094.2077529920825;6100.298465676416;6182.319944806158;992.0476342710934;998.3710262534702;999.6900960702205;1001.9298649094493;1007.9748006299754;4009.2382447334912;4069.613386728256;4069.9389509157386;4078.857239996586;4102.3026085565525;10786.352818830896;10934.835977460345;10958;11064.723381915517;11133.944330278297;10881.891181088087;10993.945030274797;11006.834897476545;11046.447677616086;11052.613158539412;7844.333231675258;7845.450818442654;7867.449278550561;7938.087119981161;8021.358291336679;5240.5807535397835;6026.126211699367;6075.422834830684;6215.595986260879;6242;9857.211423085993;9925.801483970135;10322.329048611817;10327.896721032694;10375.688729338131;10204.336718113298;10243;10412;10554.841677374692;10631.202659800701;7435.182129965808;7727.884081738891;7732.685443474736;7793.337566306701;7857.33212676906;8622.008469026143;8640.04959454472;8706.259967902799;8712.78218044554;8718.346124040596;7031.1211098612675;7256.238094999949;7260.600666963368;7338.70645174187;7420.703171873065;6259.405356491126;7121.465890058163;7123.430125590044;7164.889442136478;7180;6314.55798094129;7211.4230861532005;7274.745383911538;7293.671784769805;7308.123025237006;4317.654587633045;5083.364579427572;5129.74351282427;5136.460671629425;5222.772648427693;5124;5178.559822415137;5204.505571970657;5207.453217412117;5305.389880163831 17:14:03 INFO - PROCESS | 1663 | |4;prototype.html;303.88452388092537;310.2290807343751;314.9857458982077;320.0558352859065;320.18991950365586;4249.851255206061;5042.243663450479;5203.6357454978115;5241.266222728811;5288.391834938983;4341.500727416348;4541.455025396949;4602.81588736451;4887.804487820483;5610.4670056344685;3706.9805803404147;3903.9804800975953;4093.488313960755;4280.507741609716;4283.01490657149;3544.9113772155642;4157.293260145767;4190.811413486385;4268.615824575788;4304.610940927784;3185.904422867318;3830.272248272819;3847.942280865789;4177.540470548237;4219.831206751726;3516.6307537708426;4241.724287921275;4242.38485419614;4244.363345498185;4254.7021708480415;3028.531162386241;3494.493298471733;3636.2909232699635;3682.208325210066;3696.9445458318146;4324.545922678137;5384.138537833967;5424.403315635277;5464.836054918359;5518.613697041209;4434.846939795644;4503.819847206108;4860.493247093413;4890.73100979446;4906.632002599819;5180.456052114511;5430.886668233043;5453.445767956114;5709.314882214161;5998.440405494603;3205.4550726376574;3347.96652033479;3960.980195099006;4003.3594624859884;4008.7995600220165;5963;6256.499480041632;6260.342664020303;6293.244810622708;6340.714667840004;3910.3156947534067;3988.222296652125;4002.3796311571755;4028.194361127786;4050.987253186703;3771.9622803771613;4072.3099913535552;4086.836526538965;4094.4267802507675;4098.877033688994;4242.512111107262;4809.591184749335;4833.03339332128;4865.829695960624;4873.902521949542;5151.5363617274625;5921.726828731843;6041.456268935729;6054.5781687325425;6068.75724971005;1048.365738728074;1369.760291948905;1392.9344051800178;1401.1593044173414;1402.8036074949516;756.7843164698145;902.6163880350956;910.4719262827545;914.5975770661021;943.6555657185078;5384.6499977501335;5483.561315094783;5489.972550137303;5524.0722417119;5577.609567330248;4953.504649535018;5324.787008519694;5426.810061647823;6106.72519736613;6107.877842443127;5276.683398996072;5455.863603409946;5485.286912701403;5491.258680078218;5512.33851937762;2694.9595756063673;2713.796465265113;2755.2836262571877;2756.8483733394855;2786.8885244590397;4611.2852507861335;4732.668713190113;4761.595264402565;4841.782119804618;5328.813491527778;4829.599416169342;5149.150390185652;5334.466553344712;5336.599755018312;5366.899785543954;4898.90202195954;4910.410750709938;5155.664881782672;5400.567954563626;5444.809431669793;5046.142155833444;5168.922466162935;5194.117000110066;5213.921791173211;5234.633575649668;4658.066902235534;4658.953410465988;4807.725952622488;4931.605471562195;5207.6875387476875;4234.259004674108;5142.6914385137015;5158.561522270649;5267.236250743697;5402.702851343214;3197.6482586915886;3303.933921321608;3406.591209054929;3518.6305437929673;3568.3041806847414;4366.541513141075;4746.952530474651;5262.868428289324;5833.125031245348;6041.395860413923;5176.7152806594495;5373.758180881791;5794.797182098607;5920.200772895604;5954.910676339945;4903.828366007173;5921.792737254175;5954.166416701579;5957;5957.344692083954;5056.494350564914;5570.108782594765;5628.662280263197;5837.29952405714;5914.9944509432635;5403.6217464778665;5946.554008449297;5965.2245208124405;5969.910451343147;5975.177570840935;5521.4478552144465;5827.504662103769;5864.091065884794;5881.882362352814;5889 17:14:03 INFO - PROCESS | 1663 | |5;yui.html;673.3502170405554;706.2265975649068;726.5204964723282;775.9495632783869;843.1610547505234;14901.105933643976;15595.610109747262;15648.139352335616;15663.60840978976;15699.058056516602;14083.225422601752;14103.647408814784;14206.431742730278;14208.218547979857;14212.289385530708;686.114911763824;843.1315744782853;843.7257891185374;863.1282404771194;877.2192748453881;853.2320911179926;856.5032281276875;861.2980420956932;861.750092473182;862.0861886400404;895.8924929008529;914.4650379527951;918.164470331998;919.2599957034585;919.4575200631626;873.8339715454043;883.9955800221022;888.7689200807772;912.1106920752246;912.95891684874;583.4690431707169;652.866162436704;678.3657280442802;683.3474032299142;684.9075374824384;11573.611166660055;12797.872021279762;14404.927975360057;14726.705465890622;15115.848841511664;14609.634759131;14659.706805863929;14714.632134196623;14738;14757.631059223606;11802.94098529502;11876.287422754662;12048.638540843702;12061.33662648554;12303.876961230362;3915.197384536163;3948.2695701295065;4065.715399922007;4073.7555746655;4083.7549747015273;90265;105872.35319117007;107649.99999999921;108905;113764;8783.780405489786;10125.59497620087;10466.68599942003;11239.438028098562;11704.414779261004;21881.890590547264;22706.886465567568;22733.545329093326;22794.886025569765;22806.31581052571;6936.549124306904;8082.9191708083345;8214.342852571779;8225.753227403187;8255.587220638945;4486.1924853526025;4567.703099298535;4593.747343896118;4607.95392046082;4733.739644319596;3548.0952357149276;3662.1577037281572;3667.651573100551;3669.7064234861145;3901.297766402018;730.3828265115968;731.5391303478774;736.8820988641792;738.8928605352194;749.3817600479626;494.8070252601488;499.4605825708226;564.2805423085599;573.1631817546429;665.5806841689802;9439.575219115157;9631.470269135265;9632.807343853225;9670.90329096714;9815.950920245354;539.6654074473773;546.4207939584054;659.1299484680272;669.0395002115619;669.9196096468357;4543.273076307841;4742.430908291027;4762.9523704763205;4778.133362351692;4797.160496913027;155854;161910;167187.3281267196;170502.14748926423;173412;86239;116152;139542;143906;145022;122360;123366;124064.37967810284;124457;125492.1176182358;9087;9111.038912353379;9116.589753460978;9140.862887056832;9216.124468175512;52163;64607.67696161677;65994.34005660073;67189;67359.66320168563;67874.87313831976;81786;84145;85915;96863.51568242113;13072;13073.542426015043;13121.409536571067;13195.67010824737;13593.184408935496;14525.418983240552;14823.703525929637;15180.316885739947;15194.468193613171;15538;13600.455981760619;13946.930265348608;13958.720825583228;14050.508232211823;14074.718505630035;13538.916886649242;13679;13702.588922331946;13972;14093.929530352283;13305.800412994007;13396.732065358834;13598.388072536562;13747.793783093062;14244.572662820132;10349.551062851357;11157.497912594115;11202.215844891105;11289.943550282196;11743.354115523729;9722.78465191851;9975.152112070555;10846.728831779268;11628.302301861915;11634.476448559666 17:14:03 INFO - PROCESS | 1663 | __end_tp_report 17:14:03 INFO - PROCESS | 1663 | __start_cc_report 17:14:03 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,445 17:14:03 INFO - PROCESS | 1663 | __end_cc_report 17:14:03 INFO - PROCESS | 1663 | __startTimestamp1467418443109__endTimestamp 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | ------- Summary: start ------- 17:14:03 INFO - PROCESS | 1663 | Number of tests: 6 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5777.74 Median:6072.18 stddev:670.03 (11.0%) stddev-sans-first:635.11 17:14:03 INFO - PROCESS | 1663 | Values: 2979.6 3340.0 3435.6 3471.4 3498.0 5051.5 5800.0 5838.9 5871.0 5919.6 5338.2 5517.8 5859.6 5908.6 5996.0 5289.3 5337.7 5342.4 5445.8 5493.5 4600.3 5463.8 5516.9 5553.9 5557.4 4451.6 5233.5 5292.2 5316.9 5387.6 5339.9 5354.7 5379.2 5400.0 5434.0 4335.7 5348.5 5380.0 5397.3 5419.5 4860.9 5811.7 5841.4 5974.7 5978.1 5198.0 6224.0 6250.8 6259.6 6266.7 6176.7 6187.9 6289.0 6296.9 6318.7 5013.4 5967.7 6064.6 6069.7 6075.8 4840.5 6080.1 6287.6 6428.5 6501.9 5779.9 5902.8 6181.1 6241.8 6279.2 6254.3 6294.6 6306.2 6325.7 6382.8 6104.9 6142.2 6210.8 6239.2 6306.7 5117.6 6138.0 6149.8 6194.1 6216.1 5042.4 5088.8 5107.4 5114.8 5143.2 4521.9 4542.2 4554.7 4582.6 4622.7 5832.6 5941.6 5947.9 5992.6 6039.3 5043.9 6181.1 6278.2 6310.3 6406.5 4992.5 5970.0 5971.6 6034.3 6051.0 5473.7 5512.3 5515.6 5588.6 5616.7 5739.0 6464.7 6487.6 6496.4 6507.9 6260.2 6264.0 6274.5 6289.9 6290.5 6213.4 6344.1 6370.3 6432.2 6485.2 6244.2 6257.6 6259.3 6288.2 6291.3 6248.9 6255.2 6255.7 6257.2 6271.5 6072.2 6103.2 6140.9 6143.1 6163.9 6143.7 6162.7 6204.1 6204.3 6235.3 5106.4 6104.9 6184.9 6186.8 6195.7 6107.3 6114.0 6132.4 6157.9 6225.3 6130.5 6138.7 6150.3 6157.5 6162.4 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:73646.11 Median:39863.60 stddev:168853.97 (423.6%) stddev-sans-first:169238.27 17:14:03 INFO - PROCESS | 1663 | Values: 470.7 477.2 502.5 529.1 570.1 38234.0 40583.6 40660.4 40871.4 40949.0 40389.6 40557.0 40956.2 41023.8 41157.4 9450.6 9466.0 9476.7 9486.9 9535.3 9514.4 9605.3 9649.0 9649.7 9668.7 9518.4 9596.7 9615.0 9663.8 9664.0 9571.0 9638.8 9652.5 9655.1 9659.8 9612.8 9647.0 9662.7 9665.6 9675.1 38861.4 39089.6 39415.0 39436.8 39792.6 3317.3 3332.6 3338.7 3362.3 3501.1 30809.5 31888.8 31987.5 32742.3 32995.8 3241.3 3315.9 3328.3 3386.8 3426.9 516825.0 523129.0 524489.0 525050.0 527222.0 33803.0 62648.4 62731.4 62986.7 63307.0 33613.3 33657.5 34743.8 34893.5 34967.0 12158.3 14431.4 14701.1 14705.9 14731.3 12524.8 12587.4 12590.8 12593.0 12654.8 6703.8 7547.7 7668.2 7700.6 7760.4 3161.6 3185.1 3213.2 3215.6 3239.0 978.7 980.8 981.3 1059.9 1107.4 30783.0 30852.2 30857.9 31197.7 31259.2 1012.7 1028.3 1112.9 1133.2 1158.9 15741.5 16072.2 16112.4 16160.2 16355.8 708744.0 725029.0 728048.0 729849.0 731200.0 55468.4 55861.0 57790.4 57993.7 58023.7 1378.8 1395.1 1412.3 1412.4 1416.6 29968.4 30122.0 30160.9 30730.0 30888.5 49469.5 50499.5 50964.0 51135.5 51203.7 602586.0 627080.0 627858.0 627875.0 628543.0 26438.5 26634.6 26722.6 26952.0 27000.3 47164.8 48079.5 48084.4 48533.3 49125.5 39820.6 40060.8 40204.8 40493.2 40795.0 39655.6 39906.6 40252.0 40876.8 41820.6 37828.6 38614.2 38885.4 38983.4 39023.4 32269.7 36066.0 36543.1 36592.3 36819.6 22165.4 25548.9 26052.0 26138.1 26450.9 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35732.20 Median:12139.24 stddev:103755.80 (854.7%) stddev-sans-first:104012.84 17:14:03 INFO - PROCESS | 1663 | Values: 343.8 349.3 377.1 393.6 404.7 19996.8 20098.6 20893.3 21068.2 21074.2 11687.9 12228.3 12251.3 12267.0 15970.0 5197.2 5337.8 5366.5 5385.4 5387.7 3879.6 5747.7 6406.8 6740.0 6804.7 5737.8 5771.9 6655.2 6730.2 6771.2 6512.0 6620.3 6637.0 6684.2 6697.3 5778.3 5785.7 5855.9 5929.9 5935.5 13320.3 13664.7 13731.0 20109.3 25461.7 2183.8 2296.1 2306.2 2543.5 2626.3 10202.2 10207.5 10321.8 10390.3 10691.7 1642.3 1941.7 1972.5 1978.9 1989.6 120892.0 123843.0 124754.4 125404.0 125599.0 8833.4 11541.1 11625.2 11699.6 11707.2 13319.4 14428.5 14520.7 14585.6 14670.9 8442.9 8530.6 8566.0 8616.6 8713.9 8527.1 8535.6 8544.7 8626.1 8633.4 4109.2 4250.7 4431.2 4595.6 4653.1 1827.9 1979.5 1979.7 1983.3 1987.5 845.4 886.8 890.5 898.4 945.1 17962.8 21858.9 21935.0 21951.0 21982.3 929.5 949.5 965.6 990.9 993.7 11494.4 11507.3 11557.2 11588.9 11770.0 614987.0 622520.0 622753.0 622958.3 624070.0 113922.0 118146.4 122456.0 135543.0 140230.0 966.4 975.1 1009.7 1016.6 1019.9 18921.0 19178.3 19298.0 19527.4 19586.0 55556.4 55994.4 56826.9 56985.4 57203.0 83375.0 83636.6 84149.0 84194.3 84741.2 6930.0 8032.4 8232.6 8290.7 8429.7 12732.4 13147.0 13182.3 13222.0 13301.4 11196.6 11313.5 11400.9 11424.5 11487.0 11108.6 11279.5 11330.2 11335.3 11336.4 11452.8 11486.3 11538.1 11590.0 11713.8 8076.8 8091.0 8260.0 8275.9 8280.0 9499.4 11401.3 11419.5 11510.0 11537.4 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5776.98 Median:4842.24 stddev:3260.00 (67.3%) stddev-sans-first:3253.32 17:14:03 INFO - PROCESS | 1663 | Values: 1502.9 1551.3 1751.6 1863.1 1887.8 8071.6 8644.1 8706.8 9215.7 9252.0 8757.9 8764.0 8784.6 8894.0 8921.8 1779.3 1922.9 2336.2 2337.3 2337.9 2306.6 2337.2 2367.6 2391.9 2399.7 2310.8 2362.8 2367.6 2376.7 2392.4 2319.6 2340.2 2370.6 2370.7 2380.0 1993.2 2295.3 2351.4 2360.4 2365.3 8089.0 8705.9 8979.1 9061.8 9078.4 4936.8 5336.1 5398.9 5410.3 5419.6 3032.8 3596.9 3725.7 3734.0 3765.2 1078.0 1097.6 1107.1 1127.9 1128.5 11711.8 11827.1 11839.3 11847.3 11875.6 4447.5 4683.1 4819.4 4865.0 4875.6 10051.9 10059.3 10070.5 10084.9 10093.3 5358.3 5361.5 5415.7 5424.9 5433.2 4034.8 4436.8 4902.3 4911.6 4962.4 3996.9 4025.4 4078.0 4082.8 4134.2 1299.5 1308.8 1316.6 1320.0 1324.7 821.8 915.6 927.3 936.2 942.8 6000.2 6027.4 6094.2 6100.3 6182.3 992.0 998.4 999.7 1001.9 1008.0 4009.2 4069.6 4069.9 4078.9 4102.3 10786.4 10934.8 10958.0 11064.7 11133.9 10881.9 10993.9 11006.8 11046.4 11052.6 7844.3 7845.5 7867.4 7938.1 8021.4 5240.6 6026.1 6075.4 6215.6 6242.0 9857.2 9925.8 10322.3 10327.9 10375.7 10204.3 10243.0 10412.0 10554.8 10631.2 7435.2 7727.9 7732.7 7793.3 7857.3 8622.0 8640.0 8706.3 8712.8 8718.3 7031.1 7256.2 7260.6 7338.7 7420.7 6259.4 7121.5 7123.4 7164.9 7180.0 6314.6 7211.4 7274.7 7293.7 7308.1 4317.7 5083.4 5129.7 5136.5 5222.8 5124.0 5178.6 5204.5 5207.5 5305.4 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4521.67 Median:4942.56 stddev:1406.98 (28.5%) stddev-sans-first:1374.85 17:14:03 INFO - PROCESS | 1663 | Values: 303.9 310.2 315.0 320.1 320.2 4249.9 5042.2 5203.6 5241.3 5288.4 4341.5 4541.5 4602.8 4887.8 5610.5 3707.0 3904.0 4093.5 4280.5 4283.0 3544.9 4157.3 4190.8 4268.6 4304.6 3185.9 3830.3 3847.9 4177.5 4219.8 3516.6 4241.7 4242.4 4244.4 4254.7 3028.5 3494.5 3636.3 3682.2 3696.9 4324.5 5384.1 5424.4 5464.8 5518.6 4434.8 4503.8 4860.5 4890.7 4906.6 5180.5 5430.9 5453.4 5709.3 5998.4 3205.5 3348.0 3961.0 4003.4 4008.8 5963.0 6256.5 6260.3 6293.2 6340.7 3910.3 3988.2 4002.4 4028.2 4051.0 3772.0 4072.3 4086.8 4094.4 4098.9 4242.5 4809.6 4833.0 4865.8 4873.9 5151.5 5921.7 6041.5 6054.6 6068.8 1048.4 1369.8 1392.9 1401.2 1402.8 756.8 902.6 910.5 914.6 943.7 5384.6 5483.6 5490.0 5524.1 5577.6 4953.5 5324.8 5426.8 6106.7 6107.9 5276.7 5455.9 5485.3 5491.3 5512.3 2695.0 2713.8 2755.3 2756.8 2786.9 4611.3 4732.7 4761.6 4841.8 5328.8 4829.6 5149.2 5334.5 5336.6 5366.9 4898.9 4910.4 5155.7 5400.6 5444.8 5046.1 5168.9 5194.1 5213.9 5234.6 4658.1 4659.0 4807.7 4931.6 5207.7 4234.3 5142.7 5158.6 5267.2 5402.7 3197.6 3303.9 3406.6 3518.6 3568.3 4366.5 4747.0 5262.9 5833.1 6041.4 5176.7 5373.8 5794.8 5920.2 5954.9 4903.8 5921.8 5954.2 5957.0 5957.3 5056.5 5570.1 5628.7 5837.3 5915.0 5403.6 5946.6 5965.2 5969.9 5975.2 5521.4 5827.5 5864.1 5881.9 5889.0 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:25367.25 Median:3931.73 stddev:41456.75 (1054.4%) stddev-sans-first:41531.59 17:14:03 INFO - PROCESS | 1663 | Values: 673.4 706.2 726.5 775.9 843.2 14901.1 15595.6 15648.1 15663.6 15699.1 14083.2 14103.6 14206.4 14208.2 14212.3 686.1 843.1 843.7 863.1 877.2 853.2 856.5 861.3 861.8 862.1 895.9 914.5 918.2 919.3 919.5 873.8 884.0 888.8 912.1 913.0 583.5 652.9 678.4 683.3 684.9 11573.6 12797.9 14404.9 14726.7 15115.8 14609.6 14659.7 14714.6 14738.0 14757.6 11802.9 11876.3 12048.6 12061.3 12303.9 3915.2 3948.3 4065.7 4073.8 4083.8 90265.0 105872.4 107650.0 108905.0 113764.0 8783.8 10125.6 10466.7 11239.4 11704.4 21881.9 22706.9 22733.5 22794.9 22806.3 6936.5 8082.9 8214.3 8225.8 8255.6 4486.2 4567.7 4593.7 4608.0 4733.7 3548.1 3662.2 3667.7 3669.7 3901.3 730.4 731.5 736.9 738.9 749.4 494.8 499.5 564.3 573.2 665.6 9439.6 9631.5 9632.8 9670.9 9816.0 539.7 546.4 659.1 669.0 669.9 4543.3 4742.4 4763.0 4778.1 4797.2 155854.0 161910.0 167187.3 170502.1 173412.0 86239.0 116152.0 139542.0 143906.0 145022.0 122360.0 123366.0 124064.4 124457.0 125492.1 9087.0 9111.0 9116.6 9140.9 9216.1 52163.0 64607.7 65994.3 67189.0 67359.7 67874.9 81786.0 84145.0 85915.0 96863.5 13072.0 13073.5 13121.4 13195.7 13593.2 14525.4 14823.7 15180.3 15194.5 15538.0 13600.5 13946.9 13958.7 14050.5 14074.7 13538.9 13679.0 13702.6 13972.0 14093.9 13305.8 13396.7 13598.4 13747.8 14244.6 10349.6 11157.5 11202.2 11289.9 11743.4 9722.8 9975.2 10846.7 11628.3 11634.5 17:14:03 INFO - PROCESS | 1663 | -------- Summary: end -------- 17:14:03 INFO - PROCESS | 1663 | 17:14:03 INFO - TEST-INFO | 1663: exit 0 17:14:03 INFO - TEST-OK | dromaeo_css | took 1112537ms 17:14:03 INFO - TEST-START | kraken 17:14:03 INFO - operating with platform_type : mac_ 17:14:03 INFO - Initialising browser for kraken test... 17:14:03 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpOMfVDC/profile http://localhost:49273/getInfo.html) 17:14:06 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 17:14:06 INFO - PROCESS | 1670 | colorDepth:24 17:14:06 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 17:14:06 INFO - PROCESS | 1670 | __metrics 17:14:06 ERROR - PROCESS | 1670 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:14:07 INFO - TEST-INFO | 1670: exit 0 17:14:07 INFO - Browser initialized. 17:14:07 INFO - Running cycle 1/1 for kraken test... 17:14:07 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/T/tmpOMfVDC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:19 INFO - PROCESS | 1672 | RSS: Main: 255545344 17:14:19 INFO - PROCESS | 1672 | 17:14:21 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:22 INFO - PROCESS | 1672 | RSS: Main: 268976128 17:14:22 INFO - PROCESS | 1672 | 17:14:25 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 17:14:25 INFO - PROCESS | 1672 | RSS: Main: 272510976 17:14:25 INFO - PROCESS | 1672 | 17:14:29 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 17:14:29 INFO - PROCESS | 1672 | RSS: Main: 272699392 17:14:29 INFO - PROCESS | 1672 | 17:14:31 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 17:14:32 INFO - PROCESS | 1672 | RSS: Main: 273776640 17:14:32 INFO - PROCESS | 1672 | 17:14:34 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:35 INFO - PROCESS | 1672 | RSS: Main: 274477056 17:14:35 INFO - PROCESS | 1672 | 17:14:37 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:38 INFO - PROCESS | 1672 | RSS: Main: 275546112 17:14:38 INFO - PROCESS | 1672 | 17:14:41 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:42 INFO - PROCESS | 1672 | RSS: Main: 275419136 17:14:42 INFO - PROCESS | 1672 | 17:14:45 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 17:14:46 INFO - PROCESS | 1672 | RSS: Main: 275685376 17:14:46 INFO - PROCESS | 1672 | 17:14:47 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:48 INFO - PROCESS | 1672 | RSS: Main: 275333120 17:14:48 INFO - PROCESS | 1672 | 17:14:50 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:50 INFO - PROCESS | 1672 | RSS: Main: 274874368 17:14:50 INFO - PROCESS | 1672 | 17:14:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:53 INFO - PROCESS | 1672 | RSS: Main: 275144704 17:14:53 INFO - PROCESS | 1672 | 17:14:56 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:57 INFO - PROCESS | 1672 | RSS: Main: 275378176 17:14:57 INFO - PROCESS | 1672 | 17:14:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:15:00 INFO - PROCESS | 1672 | RSS: Main: 275394560 17:15:00 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 17:15:02 INFO - PROCESS | 1672 | RSS: Main: 276508672 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | __start_tp_report 17:15:02 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 17:15:02 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 17:15:02 INFO - PROCESS | 1672 | |i|pagename|runs| 17:15:02 INFO - PROCESS | 1672 | |0;ai-astar;104;113;105;116;116;117;108;108;117;113 17:15:02 INFO - PROCESS | 1672 | |1;audio-beat-detection;149;135;136;152;110;134;161;135;156;107 17:15:02 INFO - PROCESS | 1672 | |2;audio-dft;194;198;190;205;214;205;193;196;200;193 17:15:02 INFO - PROCESS | 1672 | |3;audio-fft;67;76;72;105;81;80;77;60;129;60 17:15:02 INFO - PROCESS | 1672 | |4;audio-oscillator;70;71;120;71;77;82;116;69;75;117 17:15:02 INFO - PROCESS | 1672 | |5;imaging-gaussian-blur;101;110;89;86;88;87;89;101;117;85 17:15:02 INFO - PROCESS | 1672 | |6;imaging-darkroom;94;96;118;133;113;91;137;152;96;95 17:15:02 INFO - PROCESS | 1672 | |7;imaging-desaturate;104;104;146;139;95;96;96;94;137;96 17:15:02 INFO - PROCESS | 1672 | |8;json-parse-financial;56;59;57;57;58;60;56;58;58;58 17:15:02 INFO - PROCESS | 1672 | |9;json-stringify-tinderbox;68;68;69;76;81;79;75;67;70;60 17:15:02 INFO - PROCESS | 1672 | |10;stanford-crypto-aes;84;85;83;86;82;85;82;87;89;94 17:15:02 INFO - PROCESS | 1672 | |11;stanford-crypto-ccm;149;152;153;150;135;135;160;153;200;141 17:15:02 INFO - PROCESS | 1672 | |12;stanford-crypto-pbkdf2;168;165;169;167;163;165;232;181;163;166 17:15:02 INFO - PROCESS | 1672 | |13;stanford-crypto-sha256-iterative;69;67;67;66;69;65;67;65;68;66 17:15:02 INFO - PROCESS | 1672 | __end_tp_report 17:15:02 INFO - PROCESS | 1672 | __start_cc_report 17:15:02 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1115 17:15:02 INFO - PROCESS | 1672 | __end_cc_report 17:15:02 INFO - PROCESS | 1672 | __startTimestamp1467418502580__endTimestamp 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | ------- Summary: start ------- 17:15:02 INFO - PROCESS | 1672 | Number of tests: 14 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#0] ai-astar Cycles:10 Average:111.70 Median:114.50 stddev:5.03 (4.4%) stddev-sans-first:4.50 17:15:02 INFO - PROCESS | 1672 | Values: 104.0 113.0 105.0 116.0 116.0 117.0 108.0 108.0 117.0 113.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:142.50 stddev:18.11 (12.7%) stddev-sans-first:18.72 17:15:02 INFO - PROCESS | 1672 | Values: 149.0 135.0 136.0 152.0 110.0 134.0 161.0 135.0 156.0 107.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#2] audio-dft Cycles:10 Average:198.80 Median:199.00 stddev:7.35 (3.7%) stddev-sans-first:7.58 17:15:02 INFO - PROCESS | 1672 | Values: 194.0 198.0 190.0 205.0 214.0 205.0 193.0 196.0 200.0 193.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#3] audio-fft Cycles:10 Average:80.70 Median:74.00 stddev:21.29 (28.8%) stddev-sans-first:22.00 17:15:02 INFO - PROCESS | 1672 | Values: 67.0 76.0 72.0 105.0 81.0 80.0 77.0 60.0 129.0 60.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:71.00 stddev:21.66 (30.5%) stddev-sans-first:22.11 17:15:02 INFO - PROCESS | 1672 | Values: 70.0 71.0 120.0 71.0 77.0 82.0 116.0 69.0 75.0 117.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:86.50 stddev:11.28 (13.0%) stddev-sans-first:11.78 17:15:02 INFO - PROCESS | 1672 | Values: 101.0 110.0 89.0 86.0 88.0 87.0 89.0 101.0 117.0 85.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:92.50 stddev:21.77 (23.5%) stddev-sans-first:22.04 17:15:02 INFO - PROCESS | 1672 | Values: 94.0 96.0 118.0 133.0 113.0 91.0 137.0 152.0 96.0 95.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#7] imaging-desaturate Cycles:10 Average:110.70 Median:94.50 stddev:21.09 (22.3%) stddev-sans-first:22.23 17:15:02 INFO - PROCESS | 1672 | Values: 104.0 104.0 146.0 139.0 95.0 96.0 96.0 94.0 137.0 96.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:58.00 stddev:1.25 (2.2%) stddev-sans-first:1.17 17:15:02 INFO - PROCESS | 1672 | Values: 56.0 59.0 57.0 57.0 58.0 60.0 56.0 58.0 58.0 58.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:72.50 stddev:6.36 (8.8%) stddev-sans-first:6.63 17:15:02 INFO - PROCESS | 1672 | Values: 68.0 68.0 69.0 76.0 81.0 79.0 75.0 67.0 70.0 60.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.50 stddev:3.65 (4.3%) stddev-sans-first:3.82 17:15:02 INFO - PROCESS | 1672 | Values: 84.0 85.0 83.0 86.0 82.0 85.0 82.0 87.0 89.0 94.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:152.50 stddev:18.49 (12.1%) stddev-sans-first:19.56 17:15:02 INFO - PROCESS | 1672 | Values: 149.0 152.0 153.0 150.0 135.0 135.0 160.0 153.0 200.0 141.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:167.50 stddev:21.06 (12.6%) stddev-sans-first:22.23 17:15:02 INFO - PROCESS | 1672 | Values: 168.0 165.0 169.0 167.0 163.0 165.0 232.0 181.0 163.0 166.0 17:15:02 INFO - PROCESS | 1672 | 17:15:02 INFO - PROCESS | 1672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:67.00 stddev:1.45 (2.2%) stddev-sans-first:1.32 17:15:02 INFO - PROCESS | 1672 | Values: 69.0 67.0 67.0 66.0 69.0 65.0 67.0 65.0 68.0 66.0 17:15:02 INFO - PROCESS | 1672 | -------- Summary: end -------- 17:15:02 INFO - PROCESS | 1672 | 17:15:03 INFO - TEST-INFO | 1672: exit 0 17:15:03 INFO - TEST-OK | kraken | took 59850ms 17:15:03 INFO - SUITE-END | took 1172s 17:15:03 INFO - Completed test suite (00:19:32) 17:15:03 INFO - javascript benchmark 17:15:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7322.775205152023, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.5828583998236, 3339.983300083499, 3435.5877294724637, 3471.44456886898, 3497.965020349796, 5051.469595692454, 5799.9560079185785, 5838.941610583893, 5870.970645146774, 5919.615225010377, 5338.172583249593, 5517.751701173447, 5859.589828711981, 5908.556858235639, 5996.0, 5289.338832645919, 5337.70642614656, 5342.439043900393, 5445.754941027643, 5493.533049690781, 4600.263957766758, 5463.7814487420455, 5516.862078448031, 5553.888922221553, 5557.360903496109, 4451.577100175478, 5233.528982391584, 5292.153255479105, 5316.946830531684, 5387.568994480452, 5339.946600533984, 5354.732263386815, 5379.246905433242, 5399.973000134974, 5434.0, 4335.6965012449145, 5348.491893270133, 5380.0, 5397.325334333208, 5419.5393391561765, 4860.878478038042, 5811.651300921916, 5841.357450680422, 5974.6713930733795, 5978.133170690269, 5197.974010129963, 6223.968880155616, 6250.843728906768, 6259.624422534663, 6266.749330026793, 6176.660283684396, 6187.87624247517, 6289.0, 6296.87406251877, 6318.684065796738, 5013.423456302499, 5967.671778052206, 6064.575479716422, 6069.666168360694, 6075.848103797396, 4840.491748366441, 6080.118382834553, 6287.559870808999, 6428.453581445536, 6501.902471462932, 5779.942200578024, 5902.793402230901, 6181.072839074175, 6241.75032998684, 6279.152314437584, 6254.280757712831, 6294.590851594632, 6306.24325080984, 6325.746970121236, 6382.808515744535, 6104.913929256131, 6142.201513803177, 6210.7515699372425, 6239.157713708682, 6306.65313407767, 5117.616178786606, 6137.959273351834, 6149.754009839557, 6194.101855231056, 6216.067589861557, 5042.42012168598, 5088.77100530477, 5107.412647545506, 5114.795408183705, 5143.228515722597, 4521.886952826206, 4542.227821270392, 4554.658400619901, 4582.610478109398, 4622.699524530962, 5832.591718579743, 5941.554383421174, 5947.86990471809, 5992.610480318765, 6039.275286965592, 5043.924341134886, 6181.134641150243, 6278.183836101278, 6310.274318453345, 6406.455451286693, 4992.475790042066, 5970.0, 5971.552133589998, 6034.275886893601, 6051.031834906394, 5473.67157970523, 5512.3385193777, 5515.558755299567, 5588.636738612058, 5616.747246373923, 5739.0, 6464.676766161579, 6487.610743355225, 6496.447801936888, 6507.869842603216, 6260.186175797117, 6264.0, 6274.466670333073, 6289.9371006291185, 6290.465310448663, 6213.440790328892, 6344.1118243445035, 6370.331115232834, 6432.2281326241155, 6485.156929599122, 6244.219472565929, 6257.624542527463, 6259.311475737574, 6288.182536270256, 6291.307956124914, 6248.875022499616, 6255.218097737783, 6255.687215639109, 6257.1552840367785, 6271.498280137487, 6072.180255665428, 6103.155845961415, 6140.933729672948, 6143.139960405458, 6163.907541386793, 6143.662098584621, 6162.691865406622, 6204.13142160107, 6204.317525072329, 6235.282942461675, 5106.361704786902, 6104.908426373697, 6184.907226391698, 6186.752529898754, 6195.721192546256, 6107.310189946737, 6114.041198129025, 6132.355508992456, 6157.876842463036, 6225.346338634378, 6130.478909292582, 6138.662373569497, 6150.261968563801, 6157.476614487819, 6162.352952939877], "value": 5738.766685026844, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [470.7457972694745, 477.1601980514292, 502.48997267773217, 529.1375058654395, 570.1248583424444, 38234.04414889625, 40583.59416405835, 40660.39009414861, 40871.38692919609, 40949.0, 40389.59610403895, 40557.0, 40956.18087638245, 41023.79488102563, 41157.38263926036, 9450.621975120986, 9465.952670236657, 9476.715698529055, 9486.905130948706, 9535.284853636005, 9514.381565198275, 9605.327627066108, 9649.0, 9649.710508684751, 9668.661596844111, 9518.381305215173, 9596.712098637017, 9614.990426005274, 9663.806723865553, 9663.95168024159, 9570.952145239264, 9638.807223855518, 9652.469114198751, 9655.08276713711, 9659.758506037335, 9612.807743845084, 9646.951765241129, 9662.661806836726, 9665.613375464973, 9675.129238368581, 38861.41707874384, 39089.60910390916, 39415.0, 39436.802815986026, 39792.60207397947, 3317.253617935945, 3332.583427071616, 3338.666133386642, 3362.260302733395, 3501.072215862798, 30809.537856932166, 31888.840555797073, 31987.52018719721, 32742.34515309704, 32995.83502082474, 3241.2743557119074, 3315.9171020724434, 3328.3010567780793, 3386.7967921924765, 3426.9033909149084, 516825.0, 523129.0, 524489.0, 525050.0, 527222.0, 33803.0, 62648.373516264255, 62731.37268627347, 62986.68506657438, 63307.0, 33613.32773344568, 33657.49513757246, 34743.82628086894, 34893.476597851055, 34967.0, 12158.331291779037, 14431.42274309016, 14701.117932924059, 14705.926470367795, 14731.263436828116, 12524.812127817908, 12587.37063146839, 12590.81113783294, 12593.0, 12654.81017784734, 6703.765368212089, 7547.73582924595, 7668.194839541879, 7700.614969251515, 7760.417968652374, 3161.6129821984255, 3185.0604071798875, 3213.22882508201, 3215.5980502437196, 3238.951415728766, 978.7161723100221, 980.7793246519618, 981.3375971219398, 1059.8659434405113, 1107.396468924438, 30783.0, 30852.22869428282, 30857.919972801294, 31197.688023119477, 31259.218519537193, 1012.696191142669, 1028.2699283508794, 1112.9165312601588, 1133.2124173699365, 1158.9420528973517, 15741.527754167164, 16072.196390180445, 16112.355505779871, 16160.191990400433, 16355.754663680054, 708744.0, 725029.0, 728048.0, 729849.0, 731200.0, 55468.44531554633, 55861.0, 57790.422095779344, 57993.71003144957, 58023.70988145117, 1378.800073989266, 1395.051365071761, 1412.2585642537545, 1412.3785534364847, 1416.5750274917484, 29968.400631986802, 30122.039481894433, 30160.944366947053, 30730.0, 30888.536671950387, 49469.50530494793, 50499.49500504948, 50963.98072038464, 51135.48864511307, 51203.743981279855, 602586.0, 627080.0, 627858.0, 627875.0, 628543.0, 26438.471230575666, 26634.600480992412, 26722.59916101299, 26952.0, 27000.32499187536, 47164.820879478284, 48079.519204807504, 48084.393670475554, 48533.27200092072, 49125.508744913524, 39820.60179398169, 40060.79969600133, 40204.79897600493, 40493.1901361977, 40795.0, 39655.60344396634, 39906.60093399029, 40252.0, 40876.79561602173, 41820.58179418167, 37828.62171378251, 38614.2277154461, 38885.416718748675, 38983.415248770725, 39023.414648779726, 32269.67730322667, 36066.0, 36543.08642283964, 36592.26815463623, 36819.63180368269, 22165.445863853533, 25548.872255638602, 26052.0, 26138.085167019064, 26450.867745661148], "value": 18938.303690262666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.78985969387753, 349.3223147094637, 377.11190147203337, 393.590665707664, 404.7187204892599, 19996.800031999675, 20098.59802803943, 20893.268735594258, 21068.157273709054, 21074.15703371863, 11687.941560292187, 12228.266304021743, 12251.326177060258, 12267.0, 15970.0, 5197.168453047513, 5337.839864804062, 5366.490183432567, 5385.434529374418, 5387.676739395629, 3879.5538513070933, 5747.655140691551, 6406.775762848301, 6739.966300168492, 6804.7278108875835, 5737.827865164052, 5771.913421298684, 6655.168103987002, 6730.226024007253, 6771.153605799275, 6511.967440162793, 6620.30486798884, 6637.004449332615, 6684.16447944007, 6697.296783837724, 5778.306603207642, 5785.739641716091, 5855.912161317584, 5929.851753706149, 5935.525157987394, 13320.267385293804, 13664.726705465935, 13731.0, 20109.29617463382, 25461.745382546123, 2183.825293976494, 2296.1389478945393, 2306.238941149417, 2543.465872166847, 2626.290901456596, 10202.183825293958, 10207.540660670287, 10321.793564128751, 10390.324628899172, 10691.732706682318, 1642.3266460751036, 1941.6602094633524, 1972.5463143477082, 1978.9017095511986, 1989.641864464396, 120892.0, 123843.0, 124754.37622811919, 125404.0, 125599.0, 8833.425827321204, 11541.07671386287, 11625.2443591168, 11699.649010529698, 11707.239029463057, 13319.40062697181, 14428.495002674856, 14520.709585808225, 14585.562433127023, 14670.926645366704, 8442.915570844336, 8530.616122274512, 8566.0, 8616.569171541398, 8713.912860871436, 8527.062023177445, 8535.615897284513, 8544.700935467354, 8626.094260102724, 8633.39566230358, 4109.157622687401, 4250.702450828474, 4431.158079964796, 4595.609373203315, 4653.068976374767, 1827.921223644797, 1979.5051237190703, 1979.6733538966198, 1983.2761042219486, 1987.5031242189452, 845.3913182508584, 886.7871710789364, 890.5102193793388, 898.3801177187851, 945.0832692288469, 17962.820371796377, 21858.89070554637, 21935.0, 21951.01220445084, 21982.34052978413, 929.5445231836487, 949.5299826585884, 965.6234068713208, 990.9058639429243, 993.6869885985891, 11494.42527873603, 11507.309561426342, 11557.248778829517, 11588.88411115895, 11769.999550038172, 614987.0, 622520.0, 622753.0, 622958.3401599717, 624070.0, 113922.0, 118146.40926795483, 122456.0, 135543.0, 140230.0, 966.3622009473854, 975.1321324021626, 1009.7122320138872, 1016.6136867990116, 1019.8929112443235, 18921.0, 19178.328758493386, 19298.0, 19527.414177574694, 19586.0, 55556.444435555124, 55994.44005560055, 56826.863462729685, 56985.43014569967, 57203.0, 83375.0, 83636.58181709053, 84149.0, 84194.31611367861, 84741.15258847333, 6929.965350173217, 8032.357411407191, 8232.62953167097, 8290.679179652921, 8429.747107586782, 12732.363381830686, 13147.013973952184, 13182.340882956005, 13222.008349373644, 13301.401436935168, 11196.608118716133, 11313.547458101913, 11400.94299528497, 11424.485898134437, 11486.966173044466, 11108.61119860801, 11279.492422841156, 11330.206885517935, 11335.263207891461, 11336.433178340885, 11452.82820757706, 11486.310821350746, 11538.134639901873, 11589.956903878692, 11713.824292635447, 8076.798080048045, 8091.0, 8260.008798944165, 8275.875861861956, 8280.0, 9499.43003419797, 11401.315921044765, 11419.543218271176, 11510.0, 11537.423128843691], "value": 9515.578026371275, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1502.8647421732041, 1551.3019141386376, 1751.562109472631, 1863.142954241049, 1887.8206570375826, 8071.6367763450635, 8644.135586441353, 8706.825863482727, 9215.723528294162, 9251.953740231305, 8757.91242087579, 8763.95618021909, 8784.60469278884, 8894.021657617657, 8921.776955576097, 1779.3238569343632, 1922.903854807261, 2336.19401306549, 2337.28712742613, 2337.8831058447095, 2306.550222706573, 2337.1819863047967, 2367.5501654685554, 2391.868447235401, 2399.748026457214, 2310.849794763343, 2362.7637236276405, 2367.573836709392, 2376.66726658268, 2392.3779817247555, 2319.617263151578, 2340.204330527629, 2370.5851475991717, 2370.6799582056374, 2379.9762002380016, 1993.2226431691506, 2295.2884605772097, 2351.412146963259, 2360.386299562109, 2365.31405892291, 8088.9595552021865, 8705.869411958825, 8979.057198994142, 9061.818763624691, 9078.409903356262, 4936.753162341868, 5336.092864213093, 5398.8920221595745, 5410.323709536308, 5419.647722898038, 3032.848357582112, 3596.946045809315, 3725.6646901778972, 3733.981330093332, 3765.2093060457337, 1078.040778064212, 1097.6158344579333, 1107.0755918807806, 1127.9436028198638, 1128.4808987865592, 11711.824322635168, 11827.053835693125, 11839.348835814028, 11847.289162650268, 11875.584354547549, 4447.466304043535, 4683.086798074342, 4819.445763737145, 4865.026994601023, 4875.561199492063, 10051.899481005243, 10059.346142500714, 10070.546825392876, 10084.899151008543, 10093.293469457067, 5358.27663265462, 5361.517463428232, 5415.729213539386, 5424.891502169935, 5433.157860531544, 4034.838606455709, 4436.755978421218, 4902.28916807061, 4911.607071434277, 4962.379702537183, 3996.9200615987515, 4025.3961905714377, 4077.9796101019306, 4082.81627326771, 4134.214499245134, 1299.4542292237284, 1308.7644224039575, 1316.605018494467, 1319.973600527984, 1324.6820763016806, 821.8068753842842, 915.5834095486538, 927.3369540778241, 936.2463217110292, 942.79258563116, 6000.249968753906, 6027.397260274025, 6094.2077529920825, 6100.298465676416, 6182.319944806158, 992.0476342710934, 998.3710262534702, 999.6900960702205, 1001.9298649094493, 1007.9748006299754, 4009.2382447334912, 4069.613386728256, 4069.9389509157386, 4078.857239996586, 4102.3026085565525, 10786.352818830896, 10934.835977460345, 10958.0, 11064.723381915517, 11133.944330278297, 10881.891181088087, 10993.945030274797, 11006.834897476545, 11046.447677616086, 11052.613158539412, 7844.333231675258, 7845.450818442654, 7867.449278550561, 7938.087119981161, 8021.358291336679, 5240.5807535397835, 6026.126211699367, 6075.422834830684, 6215.595986260879, 6242.0, 9857.211423085993, 9925.801483970135, 10322.329048611817, 10327.896721032694, 10375.688729338131, 10204.336718113298, 10243.0, 10412.0, 10554.841677374692, 10631.202659800701, 7435.182129965808, 7727.884081738891, 7732.685443474736, 7793.337566306701, 7857.33212676906, 8622.008469026143, 8640.04959454472, 8706.259967902799, 8712.78218044554, 8718.346124040596, 7031.1211098612675, 7256.238094999949, 7260.600666963368, 7338.70645174187, 7420.703171873065, 6259.405356491126, 7121.465890058163, 7123.430125590044, 7164.889442136478, 7180.0, 6314.55798094129, 7211.4230861532005, 7274.745383911538, 7293.671784769805, 7308.123025237006, 4317.654587633045, 5083.364579427572, 5129.74351282427, 5136.460671629425, 5222.772648427693, 5124.0, 5178.559822415137, 5204.505571970657, 5207.453217412117, 5305.389880163831], "value": 4640.803237651596, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.88452388092537, 310.2290807343751, 314.9857458982077, 320.0558352859065, 320.18991950365586, 4249.851255206061, 5042.243663450479, 5203.6357454978115, 5241.266222728811, 5288.391834938983, 4341.500727416348, 4541.455025396949, 4602.81588736451, 4887.804487820483, 5610.4670056344685, 3706.9805803404147, 3903.9804800975953, 4093.488313960755, 4280.507741609716, 4283.01490657149, 3544.9113772155642, 4157.293260145767, 4190.811413486385, 4268.615824575788, 4304.610940927784, 3185.904422867318, 3830.272248272819, 3847.942280865789, 4177.540470548237, 4219.831206751726, 3516.6307537708426, 4241.724287921275, 4242.38485419614, 4244.363345498185, 4254.7021708480415, 3028.531162386241, 3494.493298471733, 3636.2909232699635, 3682.208325210066, 3696.9445458318146, 4324.545922678137, 5384.138537833967, 5424.403315635277, 5464.836054918359, 5518.613697041209, 4434.846939795644, 4503.819847206108, 4860.493247093413, 4890.73100979446, 4906.632002599819, 5180.456052114511, 5430.886668233043, 5453.445767956114, 5709.314882214161, 5998.440405494603, 3205.4550726376574, 3347.96652033479, 3960.980195099006, 4003.3594624859884, 4008.7995600220165, 5963.0, 6256.499480041632, 6260.342664020303, 6293.244810622708, 6340.714667840004, 3910.3156947534067, 3988.222296652125, 4002.3796311571755, 4028.194361127786, 4050.987253186703, 3771.9622803771613, 4072.3099913535552, 4086.836526538965, 4094.4267802507675, 4098.877033688994, 4242.512111107262, 4809.591184749335, 4833.03339332128, 4865.829695960624, 4873.902521949542, 5151.5363617274625, 5921.726828731843, 6041.456268935729, 6054.5781687325425, 6068.75724971005, 1048.365738728074, 1369.760291948905, 1392.9344051800178, 1401.1593044173414, 1402.8036074949516, 756.7843164698145, 902.6163880350956, 910.4719262827545, 914.5975770661021, 943.6555657185078, 5384.6499977501335, 5483.561315094783, 5489.972550137303, 5524.0722417119, 5577.609567330248, 4953.504649535018, 5324.787008519694, 5426.810061647823, 6106.72519736613, 6107.877842443127, 5276.683398996072, 5455.863603409946, 5485.286912701403, 5491.258680078218, 5512.33851937762, 2694.9595756063673, 2713.796465265113, 2755.2836262571877, 2756.8483733394855, 2786.8885244590397, 4611.2852507861335, 4732.668713190113, 4761.595264402565, 4841.782119804618, 5328.813491527778, 4829.599416169342, 5149.150390185652, 5334.466553344712, 5336.599755018312, 5366.899785543954, 4898.90202195954, 4910.410750709938, 5155.664881782672, 5400.567954563626, 5444.809431669793, 5046.142155833444, 5168.922466162935, 5194.117000110066, 5213.921791173211, 5234.633575649668, 4658.066902235534, 4658.953410465988, 4807.725952622488, 4931.605471562195, 5207.6875387476875, 4234.259004674108, 5142.6914385137015, 5158.561522270649, 5267.236250743697, 5402.702851343214, 3197.6482586915886, 3303.933921321608, 3406.591209054929, 3518.6305437929673, 3568.3041806847414, 4366.541513141075, 4746.952530474651, 5262.868428289324, 5833.125031245348, 6041.395860413923, 5176.7152806594495, 5373.758180881791, 5794.797182098607, 5920.200772895604, 5954.910676339945, 4903.828366007173, 5921.792737254175, 5954.166416701579, 5957.0, 5957.344692083954, 5056.494350564914, 5570.108782594765, 5628.662280263197, 5837.29952405714, 5914.9944509432635, 5403.6217464778665, 5946.554008449297, 5965.2245208124405, 5969.910451343147, 5975.177570840935, 5521.4478552144465, 5827.504662103769, 5864.091065884794, 5881.882362352814, 5889.0], "value": 4078.136042688386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.3502170405554, 706.2265975649068, 726.5204964723282, 775.9495632783869, 843.1610547505234, 14901.105933643976, 15595.610109747262, 15648.139352335616, 15663.60840978976, 15699.058056516602, 14083.225422601752, 14103.647408814784, 14206.431742730278, 14208.218547979857, 14212.289385530708, 686.114911763824, 843.1315744782853, 843.7257891185374, 863.1282404771194, 877.2192748453881, 853.2320911179926, 856.5032281276875, 861.2980420956932, 861.750092473182, 862.0861886400404, 895.8924929008529, 914.4650379527951, 918.164470331998, 919.2599957034585, 919.4575200631626, 873.8339715454043, 883.9955800221022, 888.7689200807772, 912.1106920752246, 912.95891684874, 583.4690431707169, 652.866162436704, 678.3657280442802, 683.3474032299142, 684.9075374824384, 11573.611166660055, 12797.872021279762, 14404.927975360057, 14726.705465890622, 15115.848841511664, 14609.634759131, 14659.706805863929, 14714.632134196623, 14738.0, 14757.631059223606, 11802.94098529502, 11876.287422754662, 12048.638540843702, 12061.33662648554, 12303.876961230362, 3915.197384536163, 3948.2695701295065, 4065.715399922007, 4073.7555746655, 4083.7549747015273, 90265.0, 105872.35319117007, 107649.99999999921, 108905.0, 113764.0, 8783.780405489786, 10125.59497620087, 10466.68599942003, 11239.438028098562, 11704.414779261004, 21881.890590547264, 22706.886465567568, 22733.545329093326, 22794.886025569765, 22806.31581052571, 6936.549124306904, 8082.9191708083345, 8214.342852571779, 8225.753227403187, 8255.587220638945, 4486.1924853526025, 4567.703099298535, 4593.747343896118, 4607.95392046082, 4733.739644319596, 3548.0952357149276, 3662.1577037281572, 3667.651573100551, 3669.7064234861145, 3901.297766402018, 730.3828265115968, 731.5391303478774, 736.8820988641792, 738.8928605352194, 749.3817600479626, 494.8070252601488, 499.4605825708226, 564.2805423085599, 573.1631817546429, 665.5806841689802, 9439.575219115157, 9631.470269135265, 9632.807343853225, 9670.90329096714, 9815.950920245354, 539.6654074473773, 546.4207939584054, 659.1299484680272, 669.0395002115619, 669.9196096468357, 4543.273076307841, 4742.430908291027, 4762.9523704763205, 4778.133362351692, 4797.160496913027, 155854.0, 161910.0, 167187.3281267196, 170502.14748926423, 173412.0, 86239.0, 116152.0, 139542.0, 143906.0, 145022.0, 122360.0, 123366.0, 124064.37967810284, 124457.0, 125492.1176182358, 9087.0, 9111.038912353379, 9116.589753460978, 9140.862887056832, 9216.124468175512, 52163.0, 64607.67696161677, 65994.34005660073, 67189.0, 67359.66320168563, 67874.87313831976, 81786.0, 84145.0, 85915.0, 96863.51568242113, 13072.0, 13073.542426015043, 13121.409536571067, 13195.67010824737, 13593.184408935496, 14525.418983240552, 14823.703525929637, 15180.316885739947, 15194.468193613171, 15538.0, 13600.455981760619, 13946.930265348608, 13958.720825583228, 14050.508232211823, 14074.718505630035, 13538.916886649242, 13679.0, 13702.588922331946, 13972.0, 14093.929530352283, 13305.800412994007, 13396.732065358834, 13598.388072536562, 13747.793783093062, 14244.572662820132, 10349.551062851357, 11157.497912594115, 11202.215844891105, 11289.943550282196, 11743.354115523729, 9722.78465191851, 9975.152112070555, 10846.728831779268, 11628.302301861915, 11634.476448559666], "value": 7877.001466785592, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 105.0, 116.0, 116.0, 117.0, 108.0, 108.0, 117.0, 113.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 135.0, 136.0, 152.0, 110.0, 134.0, 161.0, 135.0, 156.0, 107.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 198.0, 190.0, 205.0, 214.0, 205.0, 193.0, 196.0, 200.0, 193.0], "value": 198.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 72.0, 105.0, 81.0, 80.0, 77.0, 60.0, 129.0, 60.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 120.0, 71.0, 77.0, 82.0, 116.0, 69.0, 75.0, 117.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 89.0, 86.0, 88.0, 87.0, 89.0, 101.0, 117.0, 85.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 118.0, 133.0, 113.0, 91.0, 137.0, 152.0, 96.0, 95.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 104.0, 146.0, 139.0, 95.0, 96.0, 96.0, 94.0, 137.0, 96.0], "value": 110.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 57.0, 57.0, 58.0, 60.0, 56.0, 58.0, 58.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 76.0, 81.0, 79.0, 75.0, 67.0, 70.0, 60.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 83.0, 86.0, 82.0, 85.0, 82.0, 87.0, 89.0, 94.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 152.0, 153.0, 150.0, 135.0, 135.0, 160.0, 153.0, 200.0, 141.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 169.0, 167.0, 163.0, 165.0, 232.0, 181.0, 163.0, 166.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 66.0, 69.0, 65.0, 67.0, 65.0, 68.0, 66.0], "value": 66.9, "unit": "score"}]}]} 17:15:03 INFO - Return code: 0 17:15:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:15:03 ERROR - # TBPL SUCCESS # 17:15:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:15:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:15:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:15:03 INFO - 2016-07-01 17:15:03.924 screenresolution[1677:10917] starting screenresolution argv=screenresolution get 17:15:03 INFO - 2016-07-01 17:15:03.927 screenresolution[1677:10917] Display 0: 1600x1200x32@60 17:15:03 INFO - 2016-07-01 17:15:03.933 screenresolution[1678:10920] starting screenresolution argv=screenresolution list 17:15:03 INFO - Available Modes on Display 0 17:15:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:15:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:15:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:15:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:15:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:15:04 INFO - Intel Iris: 17:15:04 INFO - Chipset Model: Intel Iris 17:15:04 INFO - Type: GPU 17:15:04 INFO - Bus: Built-In 17:15:04 INFO - VRAM (Dynamic, Max): 1536 MB 17:15:04 INFO - Vendor: Intel (0x8086) 17:15:04 INFO - Device ID: 0x0a2e 17:15:04 INFO - Revision ID: 0x0009 17:15:04 INFO - Displays: 17:15:04 INFO - Display: 17:15:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:15:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:15:04 INFO - Display Serial Number: 1600x1200 60 17:15:04 INFO - Main Display: Yes 17:15:04 INFO - Mirror: Off 17:15:04 INFO - Online: Yes 17:15:04 INFO - Rotation: Supported 17:15:04 INFO - Return code: 0 17:15:04 INFO - Running post-action listener: _resource_record_post_action 17:15:04 INFO - ##### 17:15:04 INFO - ##### Finished run-tests step (success) 17:15:04 INFO - ##### 17:15:04 INFO - Running post-run listener: _resource_record_post_run 17:15:04 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 31276544; Write bytes: 706616320; Read time: 192; Write time: 1981 17:15:04 INFO - TinderboxPrint: CPU usage
54.3% 17:15:04 INFO - TinderboxPrint: I/O read bytes / time
31,276,544 / 192 17:15:04 INFO - TinderboxPrint: I/O write bytes / time
706,616,320 / 1,981 17:15:04 INFO - TinderboxPrint: CPU idle
2,204.7 (45.6%) 17:15:04 INFO - TinderboxPrint: CPU system
975.9 (20.2%) 17:15:04 INFO - TinderboxPrint: CPU user
1,649.0 (34.1%) 17:15:04 INFO - TinderboxPrint: Swap in / out
433,971,200 / 0 17:15:04 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 398311936; Write bytes: 392349696; Read time: 29368; Write time: 833 17:15:04 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 29302272; Write bytes: 296489984; Read time: 176; Write time: 1105 17:15:04 INFO - Running post-run listener: _upload_blobber_files 17:15:04 INFO - Blob upload gear active. 17:15:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:15:04 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 17:15:04 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'] 17:15:04 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 17:15:05 INFO - (blobuploader) - INFO - Open directory for files ... 17:15:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:15:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:06 INFO - (blobuploader) - INFO - Done attempting. 17:15:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:15:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:15:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:07 INFO - (blobuploader) - INFO - Done attempting. 17:15:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:15:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:15:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:15:09 INFO - (blobuploader) - INFO - Done attempting. 17:15:09 INFO - (blobuploader) - INFO - Iteration through files over. 17:15:09 INFO - Return code: 0 17:15:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:15:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:15:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/155585893b78d9896bbe6955746eae3957c9e64f0d7b322f1f8f6d743fd680329681a5e0b8c43ff4cb7eaca88d6f82292c11a0e57f1dad29502daac03103bafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/684941aa58fff4de3177e57673962e45ae33d87007400e283c45cd44f6190c498d32be4a0e1aaf113ed1369d46e384e00dab1b6eb406a009afece0f5a54b6d0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a8d94ada776ee1833f75c74eca1d194fed768c86a7a6275bce367ee126c6966537f8833c8c7b9503108876e5c7a33043c7ec9d1c63709f775fa628a1fcb3410"} 17:15:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:15:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:15:09 INFO - Contents: 17:15:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/155585893b78d9896bbe6955746eae3957c9e64f0d7b322f1f8f6d743fd680329681a5e0b8c43ff4cb7eaca88d6f82292c11a0e57f1dad29502daac03103bafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/684941aa58fff4de3177e57673962e45ae33d87007400e283c45cd44f6190c498d32be4a0e1aaf113ed1369d46e384e00dab1b6eb406a009afece0f5a54b6d0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a8d94ada776ee1833f75c74eca1d194fed768c86a7a6275bce367ee126c6966537f8833c8c7b9503108876e5c7a33043c7ec9d1c63709f775fa628a1fcb3410"} 17:15:09 INFO - Running post-run listener: copy_logs_to_upload_dir 17:15:09 INFO - Copying logs to upload dir... 17:15:09 INFO - mkdir: /builds/slave/test/build/upload/logs 17:15:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1327.025001 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 7 secs) (at 2016-07-01 17:15:09.720585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 17:15:09.726194) ========= 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.RxFMBeED4x/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.FfDxharPFp/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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/155585893b78d9896bbe6955746eae3957c9e64f0d7b322f1f8f6d743fd680329681a5e0b8c43ff4cb7eaca88d6f82292c11a0e57f1dad29502daac03103bafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/684941aa58fff4de3177e57673962e45ae33d87007400e283c45cd44f6190c498d32be4a0e1aaf113ed1369d46e384e00dab1b6eb406a009afece0f5a54b6d0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a8d94ada776ee1833f75c74eca1d194fed768c86a7a6275bce367ee126c6966537f8833c8c7b9503108876e5c7a33043c7ec9d1c63709f775fa628a1fcb3410"} build_url:https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010808 build_url: 'https://queue.taskcluster.net/v1/task/CiyjT4o9Qxat62sWgG4vRA/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/155585893b78d9896bbe6955746eae3957c9e64f0d7b322f1f8f6d743fd680329681a5e0b8c43ff4cb7eaca88d6f82292c11a0e57f1dad29502daac03103bafc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/684941aa58fff4de3177e57673962e45ae33d87007400e283c45cd44f6190c498d32be4a0e1aaf113ed1369d46e384e00dab1b6eb406a009afece0f5a54b6d0c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9a8d94ada776ee1833f75c74eca1d194fed768c86a7a6275bce367ee126c6966537f8833c8c7b9503108876e5c7a33043c7ec9d1c63709f775fa628a1fcb3410"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 17:15:09.760735) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:15:09.761092) ========= 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.RxFMBeED4x/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.FfDxharPFp/Listeners TMPDIR=/var/folders/jg/x01k5sqn6dx7sgpxmxkndj5h00000w/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.005204 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 17:15:09.809566) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 17:15:09.809895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 17:15:09.810227) ========= ========= Total master_lag: 1.70 =========