builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0077 starttime: 1467676154.07 results: success (0) buildid: 20160704150324 builduid: 4e86acde70c8419fbc661dbebb014130 revision: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.068906) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.069282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.069552) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.344768) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:14.345133) ========= 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.XXSp8Mf6SL/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.434QWmdkG4/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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-04 16:49:14-- 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% 170M=0s 2016-07-04 16:49:14 (170 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.446609 ========= master_lag: 0.33 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:15.125982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:15.126275) ========= 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.XXSp8Mf6SL/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.434QWmdkG4/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.028689 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:15.227152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:49:15.227458) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XXSp8Mf6SL/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.434QWmdkG4/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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-04 16:49:15,306 truncating revision to first 12 chars 2016-07-04 16:49:15,306 Setting DEBUG logging. 2016-07-04 16:49:15,306 attempt 1/10 2016-07-04 16:49:15,306 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9a70b64f2fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 16:49:16,363 unpacking tar archive at: mozilla-central-c9a70b64f2fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.332896 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-04 16:49:16.589287) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.589568) ========= script_repo_revision: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.589958) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.590237) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:49:16.608416) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2016-07-04 16:49:16.608725) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XXSp8Mf6SL/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.434QWmdkG4/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:49:16 INFO - MultiFileLogger online at 20160704 16:49:16 in /builds/slave/test 16:49:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:49:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:49:16 INFO - {'append_to_log': False, 16:49:16 INFO - 'base_work_dir': '/builds/slave/test', 16:49:16 INFO - 'blob_upload_branch': 'Firefox', 16:49:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:49:16 INFO - 'branch': 'Firefox', 16:49:16 INFO - 'buildbot_json_path': 'buildprops.json', 16:49:16 INFO - 'config_files': ('talos/mac_config.py',), 16:49:16 INFO - 'default_actions': ('clobber', 16:49:16 INFO - 'read-buildbot-config', 16:49:16 INFO - 'download-and-extract', 16:49:16 INFO - 'populate-webroot', 16:49:16 INFO - 'create-virtualenv', 16:49:16 INFO - 'install', 16:49:16 INFO - 'run-tests'), 16:49:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:49:16 INFO - 'download_minidump_stackwalk': True, 16:49:16 INFO - 'download_symbols': 'ondemand', 16:49:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:49:16 INFO - 'tooltool.py': '/tools/tooltool.py', 16:49:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:49:16 INFO - '/tools/misc-python/virtualenv.py')}, 16:49:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:49:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:49:16 INFO - 'installer_path': 'installer.exe', 16:49:16 INFO - 'log_level': 'info', 16:49:16 INFO - 'log_name': 'talos', 16:49:16 INFO - 'log_to_console': True, 16:49:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:49:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:49:16 INFO - 'opt_config_files': (), 16:49:16 INFO - 'pip_index': False, 16:49:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:49:16 INFO - 'cmd': ('bash', 16:49:16 INFO - '-c', 16:49:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:49:16 INFO - 'enabled': True, 16:49:16 INFO - 'halt_on_failure': False, 16:49:16 INFO - 'name': 'check_screen_resolution'},), 16:49:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:49:16 INFO - 'cmd': ('bash', 16:49:16 INFO - '-c', 16:49:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:49:16 INFO - 'enabled': True, 16:49:16 INFO - 'halt_on_failure': False, 16:49:16 INFO - 'name': 'check_screen_resolution'},), 16:49:16 INFO - 'run_cmd_checks_enabled': True, 16:49:16 INFO - 'sps_profile': False, 16:49:16 INFO - 'sps_profile_interval': 0, 16:49:16 INFO - 'suite': 'dromaeojs-e10s', 16:49:16 INFO - 'system_bits': '32', 16:49:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:49:16 INFO - 'title': 't-yosemite-r7-0077', 16:49:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:49:16 INFO - 'use_talos_json': True, 16:49:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:49:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:49:16 INFO - 'work_dir': 'build'} 16:49:16 INFO - ##### 16:49:16 INFO - ##### Running clobber step. 16:49:16 INFO - ##### 16:49:16 INFO - Running pre-action listener: _resource_record_pre_action 16:49:16 INFO - Running main action method: clobber 16:49:16 INFO - rmtree: /builds/slave/test/build 16:49:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:49:18 INFO - Running post-action listener: _resource_record_post_action 16:49:18 INFO - ##### 16:49:18 INFO - ##### Finished clobber step (success) 16:49:18 INFO - ##### 16:49:18 INFO - ##### 16:49:18 INFO - ##### Running read-buildbot-config step. 16:49:18 INFO - ##### 16:49:18 INFO - Running pre-action listener: _resource_record_pre_action 16:49:18 INFO - Running main action method: read_buildbot_config 16:49:18 INFO - Using buildbot properties: 16:49:18 INFO - { 16:49:18 INFO - "project": "", 16:49:18 INFO - "product": "firefox", 16:49:18 INFO - "script_repo_revision": "production", 16:49:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 16:49:18 INFO - "repository": "", 16:49:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 16:49:18 INFO - "buildid": "20160704150324", 16:49:18 INFO - "pgo_build": "False", 16:49:18 INFO - "basedir": "/builds/slave/test", 16:49:18 INFO - "buildnumber": 39, 16:49:18 INFO - "slavename": "t-yosemite-r7-0077", 16:49:18 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 16:49:18 INFO - "platform": "yosemite_r7", 16:49:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 16:49:18 INFO - "branch": "mozilla-central", 16:49:18 INFO - "repo_path": "mozilla-central", 16:49:18 INFO - "revision": "c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5", 16:49:18 INFO - "stage_platform": "macosx64", 16:49:18 INFO - "builduid": "4e86acde70c8419fbc661dbebb014130", 16:49:18 INFO - "slavebuilddir": "test" 16:49:18 INFO - } 16:49:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 16:49:18 INFO - Running post-action listener: _resource_record_post_action 16:49:18 INFO - ##### 16:49:18 INFO - ##### Finished read-buildbot-config step (success) 16:49:18 INFO - ##### 16:49:18 INFO - ##### 16:49:18 INFO - ##### Running download-and-extract step. 16:49:18 INFO - ##### 16:49:18 INFO - Running pre-action listener: _resource_record_pre_action 16:49:18 INFO - Running main action method: download_and_extract 16:49:18 INFO - mkdir: /builds/slave/test/build/tests 16:49:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:49:18 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:49:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:49:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 16:49:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:49:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:49:49 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 16:49:49 INFO - retry: attempt #1 caught exception: timed out 16:49:49 INFO - retry: Failed, sleeping 30 seconds before retrying 16:50:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:35 INFO - Downloaded 1199 bytes. 16:50:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 16:50:35 INFO - Using the following test package requirements: 16:50:35 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:50:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 16:50:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 16:50:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'jsshell-mac.zip'], 16:50:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 16:50:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 16:50:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 16:50:35 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 16:50:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 16:50:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 16:50:35 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 16:50:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:50:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:35 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:50:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:37 INFO - Downloaded 18800185 bytes. 16:50:37 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:50:37 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:50:41 INFO - Return code: 0 16:50:41 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:50:41 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:50:41 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:50:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 16:50:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:42 INFO - Downloaded 18800185 bytes. 16:50:42 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:50:42 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:50:45 INFO - Return code: 0 16:50: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:50:45 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:50:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:50:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 16:50:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:46 INFO - Downloaded 14403333 bytes. 16:50:46 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:50:46 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:50:47 INFO - Return code: 0 16:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:50:47 INFO - https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:50:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 16:50:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZW4n2dRRRBm53rczXapIeA/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:50:50 INFO - Downloaded 112424182 bytes. 16:50:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:50 INFO - mkdir: /builds/slave/test/properties 16:50:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:50:50 INFO - Writing to file /builds/slave/test/properties/build_url 16:50:50 INFO - Contents: 16:50:50 INFO - build_url:https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 16:50:51 INFO - Running post-action listener: _resource_record_post_action 16:50:51 INFO - Running post-action listener: set_extra_try_arguments 16:50:51 INFO - ##### 16:50:51 INFO - ##### Finished download-and-extract step (success) 16:50:51 INFO - ##### 16:50:51 INFO - ##### 16:50:51 INFO - ##### Running populate-webroot step. 16:50:51 INFO - ##### 16:50:51 INFO - Running pre-action listener: _resource_record_pre_action 16:50:51 INFO - Running main action method: populate_webroot 16:50:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:51 INFO - '--tppagecycles', 16:50:51 INFO - '7'], 16:50:51 INFO - 'tests': ['tsvgm']}}, 16:50:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:50:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:50:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:50:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['damp', 'tps']}, 16:50:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'tests': ['damp', 'tps']}, 16:50:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['dromaeo_dom']}, 16:50:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['basic_compositor_video']}, 16:50:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:50:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore', 16:50:51 INFO - 'tabpaint']}, 16:50:51 INFO - 'other-e10s': {'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore', 16:50:51 INFO - 'tabpaint']}, 16:50:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore', 16:50:51 INFO - 'tabpaint']}, 16:50:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore', 16:50:51 INFO - 'tabpaint']}, 16:50:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore', 16:50:51 INFO - 'tabpaint']}, 16:50:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['a11yr', 16:50:51 INFO - 'ts_paint', 16:50:51 INFO - 'tpaint', 16:50:51 INFO - 'sessionrestore', 16:50:51 INFO - 'sessionrestore_no_auto_restore', 16:50:51 INFO - 'tabpaint']}, 16:50:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['tsvgx', 16:50:51 INFO - 'tsvgr_opacity', 16:50:51 INFO - 'tart', 16:50:51 INFO - 'tscrollx', 16:50:51 INFO - 'cart']}, 16:50:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:50:51 INFO - 'tsvgr_opacity', 16:50:51 INFO - 'tart', 16:50:51 INFO - 'tscrollx', 16:50:51 INFO - 'cart']}, 16:50:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--disable-e10s'], 16:50:51 INFO - 'tests': ['tp5o']}, 16:50:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'tests': ['tp5o']}, 16:50:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--disable-e10s', 16:50:51 INFO - '--xperf_path', 16:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:51 INFO - 'tests': ['tp5n']}, 16:50:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:51 INFO - 'talos_options': ['--xperf_path', 16:50:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:51 INFO - 'tests': ['tp5n']}}, 16:50:51 INFO - 'talos.zip': {'path': '', 16:50:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:51 INFO - Running post-action listener: _resource_record_post_action 16:50:51 INFO - ##### 16:50:51 INFO - ##### Finished populate-webroot step (success) 16:50:51 INFO - ##### 16:50:51 INFO - ##### 16:50:51 INFO - ##### Running create-virtualenv step. 16:50:51 INFO - ##### 16:50:51 INFO - Running pre-action listener: _resource_record_pre_action 16:50:51 INFO - Running main action method: create_virtualenv 16:50:51 INFO - Creating virtualenv /builds/slave/test/build/venv 16:50:51 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:50:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:50:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:51 INFO - Using real prefix '/tools/python27' 16:50:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:50:52 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:55 INFO - Installing pip.................done. 16:50:55 INFO - Return code: 0 16:50:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:50: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', 'pip>=1.5'] in /builds/slave/test/build 16:50: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 pip>=1.5 16:50:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:50:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:50:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:50:55 INFO - 'HOME': '/Users/cltbld', 16:50:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:50:55 INFO - 'LOGNAME': 'cltbld', 16:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:55 INFO - 'MOZ_NO_REMOTE': '1', 16:50:55 INFO - 'NO_EM_RESTART': '1', 16:50:55 INFO - 'PAGER': '/bin/cat', 16:50:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:55 INFO - 'PWD': '/builds/slave/test', 16:50:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:50:55 INFO - 'SHELL': '/bin/bash', 16:50:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:50:55 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:50:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:50:55 INFO - 'USER': 'cltbld', 16:50:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:50:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:55 INFO - 'XPC_FLAGS': '0x0', 16:50:55 INFO - 'XPC_SERVICE_NAME': '0', 16:50:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:55 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:50:55 INFO - Cleaning up... 16:50:55 INFO - Return code: 0 16:50:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:50: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:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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', '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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:50: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', 'psutil>=3.1.1'] in /builds/slave/test/build 16:50: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 psutil>=3.1.1 16:50:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:50:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:50:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:50:55 INFO - 'HOME': '/Users/cltbld', 16:50:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:50:55 INFO - 'LOGNAME': 'cltbld', 16:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:55 INFO - 'MOZ_NO_REMOTE': '1', 16:50:55 INFO - 'NO_EM_RESTART': '1', 16:50:55 INFO - 'PAGER': '/bin/cat', 16:50:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:55 INFO - 'PWD': '/builds/slave/test', 16:50:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:50:55 INFO - 'SHELL': '/bin/bash', 16:50:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:50:55 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:50:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:50:55 INFO - 'USER': 'cltbld', 16:50:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:50:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:55 INFO - 'XPC_FLAGS': '0x0', 16:50:55 INFO - 'XPC_SERVICE_NAME': '0', 16:50:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:55 INFO - Downloading/unpacking psutil>=3.1.1 16:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:55 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:50:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:58 INFO - Installing collected packages: psutil 16:50:58 INFO - Running setup.py install for psutil 16:50:59 INFO - building 'psutil._psutil_osx' extension 16:50:59 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:50:59 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:50:59 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:50:59 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:50:59 INFO - building 'psutil._psutil_posix' extension 16:50:59 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:50:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:50:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:50:59 INFO - ^ 16:51:00 INFO - 1 warning generated. 16:51:00 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:51:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:51:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:51:00 INFO - Successfully installed psutil 16:51:00 INFO - Cleaning up... 16:51:00 INFO - Return code: 0 16:51:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:51:00 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:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:00 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:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:00 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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:00 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:51:00 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:51:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:00 INFO - 'HOME': '/Users/cltbld', 16:51:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:00 INFO - 'LOGNAME': 'cltbld', 16:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:00 INFO - 'MOZ_NO_REMOTE': '1', 16:51:00 INFO - 'NO_EM_RESTART': '1', 16:51:00 INFO - 'PAGER': '/bin/cat', 16:51:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:00 INFO - 'PWD': '/builds/slave/test', 16:51:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:00 INFO - 'SHELL': '/bin/bash', 16:51:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:00 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:00 INFO - 'USER': 'cltbld', 16:51:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:00 INFO - 'XPC_FLAGS': '0x0', 16:51:00 INFO - 'XPC_SERVICE_NAME': '0', 16:51:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:00 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:51:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:51:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:51:02 INFO - Installing collected packages: mozsystemmonitor 16:51:02 INFO - Running setup.py install for mozsystemmonitor 16:51:03 INFO - Successfully installed mozsystemmonitor 16:51:03 INFO - Cleaning up... 16:51:03 INFO - Return code: 0 16:51:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:03 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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:03 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:51:03 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:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:03 INFO - 'HOME': '/Users/cltbld', 16:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:03 INFO - 'LOGNAME': 'cltbld', 16:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:03 INFO - 'MOZ_NO_REMOTE': '1', 16:51:03 INFO - 'NO_EM_RESTART': '1', 16:51:03 INFO - 'PAGER': '/bin/cat', 16:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:03 INFO - 'PWD': '/builds/slave/test', 16:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:03 INFO - 'SHELL': '/bin/bash', 16:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:03 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:03 INFO - 'USER': 'cltbld', 16:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:03 INFO - 'XPC_FLAGS': '0x0', 16:51:03 INFO - 'XPC_SERVICE_NAME': '0', 16:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:03 INFO - Downloading/unpacking jsonschema==2.5.1 16:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:51:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:06 INFO - Downloading functools32-3.2.3-2.tar.gz 16:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:51:06 INFO - warning: no files found matching '*.txt' 16:51:06 INFO - no previously-included directories found matching 'build' 16:51:06 INFO - no previously-included directories found matching 'dist' 16:51:06 INFO - no previously-included directories found matching '.git*' 16:51:06 INFO - Installing collected packages: jsonschema, functools32 16:51:06 INFO - Running setup.py install for functools32 16:51:06 INFO - warning: no files found matching '*.txt' 16:51:06 INFO - no previously-included directories found matching 'build' 16:51:06 INFO - no previously-included directories found matching 'dist' 16:51:06 INFO - no previously-included directories found matching '.git*' 16:51:06 INFO - Successfully installed jsonschema functools32 16:51:06 INFO - Cleaning up... 16:51:06 INFO - Return code: 0 16:51:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:51: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:51:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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:51:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:51:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:06 INFO - 'HOME': '/Users/cltbld', 16:51:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:06 INFO - 'LOGNAME': 'cltbld', 16:51:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:06 INFO - 'MOZ_NO_REMOTE': '1', 16:51:06 INFO - 'NO_EM_RESTART': '1', 16:51:06 INFO - 'PAGER': '/bin/cat', 16:51:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:06 INFO - 'PWD': '/builds/slave/test', 16:51:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:06 INFO - 'SHELL': '/bin/bash', 16:51:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:06 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:06 INFO - 'USER': 'cltbld', 16:51:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:06 INFO - 'XPC_FLAGS': '0x0', 16:51:06 INFO - 'XPC_SERVICE_NAME': '0', 16:51:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:07 INFO - Downloading/unpacking blobuploader==1.2.4 16:51:07 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:51:07 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:51:07 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:51:07 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:51:07 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:51:07 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:51:09 INFO - Downloading blobuploader-1.2.4.tar.gz 16:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:51:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 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:51:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:51:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 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:51:10 INFO - Downloading docopt-0.6.1.tar.gz 16:51:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:51:10 INFO - Installing collected packages: blobuploader, requests, docopt 16:51:10 INFO - Running setup.py install for blobuploader 16:51:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:51:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:51:10 INFO - Running setup.py install for requests 16:51:11 INFO - Running setup.py install for docopt 16:51:11 INFO - Successfully installed blobuploader requests docopt 16:51:11 INFO - Cleaning up... 16:51:11 INFO - Return code: 0 16:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51: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:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51: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:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:11 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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:11 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:51:11 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:51:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:11 INFO - 'HOME': '/Users/cltbld', 16:51:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:11 INFO - 'LOGNAME': 'cltbld', 16:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:11 INFO - 'MOZ_NO_REMOTE': '1', 16:51:11 INFO - 'NO_EM_RESTART': '1', 16:51:11 INFO - 'PAGER': '/bin/cat', 16:51:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:11 INFO - 'PWD': '/builds/slave/test', 16:51:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:11 INFO - 'SHELL': '/bin/bash', 16:51:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:11 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:11 INFO - 'USER': 'cltbld', 16:51:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:11 INFO - 'XPC_FLAGS': '0x0', 16:51:11 INFO - 'XPC_SERVICE_NAME': '0', 16:51:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:11 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-NTtUW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8ShAkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-l_81Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-D2rQva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-nT1Gm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-wpWNfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-UL1vr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-vxMwCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Z3VQzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8QmOfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:12 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Ge7rdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:13 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-WRwF_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:13 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-0JcSYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:13 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-jzNeNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:13 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-9yTXJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:13 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-yZn99_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:13 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-9iCbrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:51:13 INFO - Running setup.py install for manifestparser 16:51:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:13 INFO - Running setup.py install for mozcrash 16:51:14 INFO - Running setup.py install for mozdebug 16:51:14 INFO - Running setup.py install for mozdevice 16:51:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Running setup.py install for mozfile 16:51:14 INFO - Running setup.py install for mozhttpd 16:51:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Running setup.py install for mozinfo 16:51:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Running setup.py install for mozInstall 16:51:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:14 INFO - Running setup.py install for mozleak 16:51:15 INFO - Running setup.py install for mozlog 16:51:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:15 INFO - Running setup.py install for moznetwork 16:51:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:15 INFO - Running setup.py install for mozprocess 16:51:15 INFO - Running setup.py install for mozprofile 16:51:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:15 INFO - Running setup.py install for mozrunner 16:51:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:15 INFO - Running setup.py install for mozscreenshot 16:51:16 INFO - Running setup.py install for moztest 16:51:16 INFO - Running setup.py install for mozversion 16:51:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:16 INFO - Cleaning up... 16:51:16 INFO - Return code: 0 16:51:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:16 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:51:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:16 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:51:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:16 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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:16 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:51:16 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:51:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:16 INFO - 'HOME': '/Users/cltbld', 16:51:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:16 INFO - 'LOGNAME': 'cltbld', 16:51:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:16 INFO - 'MOZ_NO_REMOTE': '1', 16:51:16 INFO - 'NO_EM_RESTART': '1', 16:51:16 INFO - 'PAGER': '/bin/cat', 16:51:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:16 INFO - 'PWD': '/builds/slave/test', 16:51:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:16 INFO - 'SHELL': '/bin/bash', 16:51:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:16 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:16 INFO - 'USER': 'cltbld', 16:51:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:16 INFO - 'XPC_FLAGS': '0x0', 16:51:16 INFO - 'XPC_SERVICE_NAME': '0', 16:51:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-nEinpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:16 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:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-70omki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:16 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:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-nQxXqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:16 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:51:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:16 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-iBN1hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-8Ujlk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-2hzgWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-0wPEv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-qV9c76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-7Jc8M8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-Ckl08v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-rrGUGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-aSQQEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-NeYKuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:17 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:51:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:17 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-4i49SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:18 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:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:18 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-7uVWTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:18 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:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:18 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-zQO1r2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:18 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:51:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:18 INFO - Running setup.py (path:/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/pip-zaNWLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:18 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:51:20 INFO - Downloading blessings-1.6.tar.gz 16:51:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:20 INFO - Installing collected packages: blessings 16:51:20 INFO - Running setup.py install for blessings 16:51:21 INFO - Successfully installed blessings 16:51:21 INFO - Cleaning up... 16:51:21 INFO - Return code: 0 16:51:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:21 INFO - Reading from file tmpfile_stdout 16:51:21 INFO - Current package versions: 16:51:21 INFO - blessings == 1.6 16:51:21 INFO - blobuploader == 1.2.4 16:51:21 INFO - docopt == 0.6.1 16:51:21 INFO - functools32 == 3.2.3-2 16:51:21 INFO - jsonschema == 2.5.1 16:51:21 INFO - manifestparser == 1.1 16:51:21 INFO - mozInstall == 1.12 16:51:21 INFO - mozcrash == 0.17 16:51:21 INFO - mozdebug == 0.1 16:51:21 INFO - mozdevice == 0.48 16:51:21 INFO - mozfile == 1.2 16:51:21 INFO - mozhttpd == 0.7 16:51:21 INFO - mozinfo == 0.9 16:51:21 INFO - mozleak == 0.1 16:51:21 INFO - mozlog == 3.2 16:51:21 INFO - moznetwork == 0.27 16:51:21 INFO - mozprocess == 0.22 16:51:21 INFO - mozprofile == 0.28 16:51:21 INFO - mozrunner == 6.11 16:51:21 INFO - mozscreenshot == 0.1 16:51:21 INFO - mozsystemmonitor == 0.3 16:51:21 INFO - moztest == 0.7 16:51:21 INFO - mozversion == 1.4 16:51:21 INFO - psutil == 3.1.1 16:51:21 INFO - requests == 1.2.3 16:51:21 INFO - wsgiref == 0.1.2 16:51:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:21 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:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 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:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:21 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:51:21 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:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:21 INFO - 'HOME': '/Users/cltbld', 16:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:21 INFO - 'LOGNAME': 'cltbld', 16:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:21 INFO - 'MOZ_NO_REMOTE': '1', 16:51:21 INFO - 'NO_EM_RESTART': '1', 16:51:21 INFO - 'PAGER': '/bin/cat', 16:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:21 INFO - 'PWD': '/builds/slave/test', 16:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:21 INFO - 'SHELL': '/bin/bash', 16:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:21 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:21 INFO - 'USER': 'cltbld', 16:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:21 INFO - 'XPC_FLAGS': '0x0', 16:51:21 INFO - 'XPC_SERVICE_NAME': '0', 16:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 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:51:21 INFO - Cleaning up... 16:51:21 INFO - Return code: 0 16:51:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:51:21 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:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 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:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:21 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 0x1085c2a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108657618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1fb470790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, '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.XXSp8Mf6SL/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.434QWmdkG4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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:51:21 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:51:21 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:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:21 INFO - 'HOME': '/Users/cltbld', 16:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:21 INFO - 'LOGNAME': 'cltbld', 16:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:21 INFO - 'MOZ_NO_REMOTE': '1', 16:51:21 INFO - 'NO_EM_RESTART': '1', 16:51:21 INFO - 'PAGER': '/bin/cat', 16:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:21 INFO - 'PWD': '/builds/slave/test', 16:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:21 INFO - 'SHELL': '/bin/bash', 16:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:21 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:21 INFO - 'USER': 'cltbld', 16:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:21 INFO - 'XPC_FLAGS': '0x0', 16:51:21 INFO - 'XPC_SERVICE_NAME': '0', 16:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:51:21 INFO - Cleaning up... 16:51:21 INFO - Return code: 0 16:51:21 INFO - Running post-action listener: _resource_record_post_action 16:51:21 INFO - Running post-action listener: _start_resource_monitoring 16:51:21 INFO - Starting resource monitoring. 16:51:21 INFO - ##### 16:51:21 INFO - ##### Finished create-virtualenv step (success) 16:51:22 INFO - ##### 16:51:22 INFO - ##### 16:51:22 INFO - ##### Running install step. 16:51:22 INFO - ##### 16:51:22 INFO - Running pre-action listener: _resource_record_pre_action 16:51:22 INFO - Running main action method: install 16:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:22 INFO - Reading from file tmpfile_stdout 16:51:22 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:51:22 INFO - Reading from file tmpfile_stdout 16:51:22 INFO - Output received: 16:51:22 INFO - Usage: mozinstall [options] installer 16:51:22 INFO - Options: 16:51:22 INFO - -h, --help show this help message and exit 16:51:22 INFO - -d DEST, --destination=DEST 16:51:22 INFO - Directory to install application into. [default: 16:51:22 INFO - "/builds/slave/test"] 16:51:22 INFO - --app=APP Application being installed. [default: firefox] 16:51:22 INFO - mkdir: /builds/slave/test/build/application 16:51:22 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:51:22 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:51:57 INFO - Reading from file tmpfile_stdout 16:51:57 INFO - Output received: 16:51:57 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:51:57 INFO - Running post-action listener: _resource_record_post_action 16:51:57 INFO - ##### 16:51:57 INFO - ##### Finished install step (success) 16:51:57 INFO - ##### 16:51:57 INFO - ##### 16:51:57 INFO - ##### Running run-tests step. 16:51:57 INFO - ##### 16:51:57 INFO - Running pre-action listener: _resource_record_pre_action 16:51:57 INFO - Running main action method: run_tests 16:51:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:51:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:51:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:51:57 INFO - 2016-07-04 16:51:57.082 screenresolution[1645:7799] starting screenresolution argv=screenresolution get 16:51:57 INFO - 2016-07-04 16:51:57.085 screenresolution[1645:7799] Display 0: 1600x1200x32@60 16:51:57 INFO - 2016-07-04 16:51:57.091 screenresolution[1646:7801] starting screenresolution argv=screenresolution list 16:51:57 INFO - Available Modes on Display 0 16:51:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:51:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:51:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:51:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:51:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:51:57 INFO - Intel Iris: 16:51:57 INFO - Chipset Model: Intel Iris 16:51:57 INFO - Type: GPU 16:51:57 INFO - Bus: Built-In 16:51:57 INFO - VRAM (Dynamic, Max): 1536 MB 16:51:57 INFO - Vendor: Intel (0x8086) 16:51:57 INFO - Device ID: 0x0a2e 16:51:57 INFO - Revision ID: 0x0009 16:51:57 INFO - Displays: 16:51:57 INFO - Display: 16:51:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:51:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:51:57 INFO - Display Serial Number: 1600x1200 60 16:51:57 INFO - Main Display: Yes 16:51:57 INFO - Mirror: Off 16:51:57 INFO - Online: Yes 16:51:57 INFO - Rotation: Supported 16:51:57 INFO - Return code: 0 16:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:51:57 INFO - Python 2.7.3 16:51:57 INFO - Return code: 0 16:51:57 INFO - grabbing minidump binary from tooltool 16:51:57 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:51:57 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 0x108526d30>, '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 0x10828bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10851eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:51:57 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:51:57 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:51:57 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:51:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:57 INFO - Return code: 0 16:51:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:51:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:51:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:51:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:51:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:51:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--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:51:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0077 --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:51:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XXSp8Mf6SL/Render', 16:51:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:51:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:51:57 INFO - 'HOME': '/Users/cltbld', 16:51:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:51:57 INFO - 'LOGNAME': 'cltbld', 16:51:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:51:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:57 INFO - 'MOZ_NO_REMOTE': '1', 16:51:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:51:57 INFO - 'NO_EM_RESTART': '1', 16:51:57 INFO - 'PAGER': '/bin/cat', 16:51:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:57 INFO - 'PWD': '/builds/slave/test', 16:51:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:51:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:51:57 INFO - 'SHELL': '/bin/bash', 16:51:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.434QWmdkG4/Listeners', 16:51:57 INFO - 'TMPDIR': '/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/', 16:51:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:51:57 INFO - 'USER': 'cltbld', 16:51:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:51:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:57 INFO - 'XPC_FLAGS': '0x0', 16:51:57 INFO - 'XPC_SERVICE_NAME': '0', 16:51:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:51:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0077', '--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:51:57 INFO - mozversion application_buildid: 20160704150324 16:51:57 INFO - mozversion application_changeset: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 16:51:57 INFO - mozversion application_display_name: Nightly 16:51:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:57 INFO - mozversion application_name: Firefox 16:51:57 INFO - mozversion application_remotingname: firefox 16:51:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:51:57 INFO - mozversion application_vendor: Mozilla 16:51:57 INFO - mozversion application_version: 50.0a1 16:51:57 INFO - mozversion platform_buildid: 20160704150324 16:51:57 INFO - mozversion platform_changeset: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 16:51:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:51:57 INFO - mozversion platform_version: 50.0a1 16:51:57 INFO - using testdate: 1467676317 16:51:57 INFO - actual date: 1467676317 16:51:57 INFO - starting webserver on 'localhost:49288' 16:51:57 INFO - SUITE-START | Running 2 tests 16:51:57 INFO - TEST-START | dromaeo_css 16:51:57 INFO - operating with platform_type : mac_ 16:51:57 INFO - Initialising browser for dromaeo_css test... 16:51:57 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmp94wAjN/profile http://localhost:49288/getInfo.html) 16:52:00 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 16:52:00 INFO - PROCESS | 1656 | colorDepth:24 16:52:00 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 16:52:00 INFO - PROCESS | 1656 | __metrics 16:52:00 ERROR - PROCESS | 1656 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 16:52:01 INFO - TEST-INFO | 1656: exit 0 16:52:01 INFO - Browser initialized. 16:52:01 INFO - Running cycle 1/1 for dromaeo_css test... 16:52:01 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmp94wAjN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:52:13 INFO - PROCESS | 1660 | RSS: Main: 255631360 16:52:13 INFO - PROCESS | 1660 | 16:53:03 INFO - PROCESS | 1660 | 1467676383231 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:55:14 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49288/tests/dromaeo/cssquery-ext.html) 16:55:15 INFO - PROCESS | 1660 | RSS: Main: 268132352 16:55:15 INFO - PROCESS | 1660 | 16:58:17 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-ext.html (next: http://localhost:49288/tests/dromaeo/cssquery-jquery.html) 16:58:18 INFO - PROCESS | 1660 | RSS: Main: 276553728 16:58:18 INFO - PROCESS | 1660 | 17:01:20 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49288/tests/dromaeo/cssquery-mootools.html) 17:01:20 INFO - PROCESS | 1660 | RSS: Main: 281210880 17:01:20 INFO - PROCESS | 1660 | 17:04:22 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49288/tests/dromaeo/cssquery-prototype.html) 17:04:23 INFO - PROCESS | 1660 | RSS: Main: 280649728 17:04:23 INFO - PROCESS | 1660 | 17:07:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49288/tests/dromaeo/cssquery-yui.html) 17:07:26 INFO - PROCESS | 1660 | RSS: Main: 283803648 17:07:26 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49288/tests/dromaeo/cssquery-yui.html (next: http://localhost:49288/tests/dromaeo/cssquery-dojo.html) 17:10:29 INFO - PROCESS | 1660 | RSS: Main: 283910144 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | __start_tp_report 17:10:29 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 17:10:29 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 17:10:29 INFO - PROCESS | 1660 | |i|pagename|runs| 17:10:29 INFO - PROCESS | 1660 | |0;dojo.html;3375.932481350373;3379.6451372605893;3399;3404.710599599034;3405.9489107663376;5729.656220626765;5814.273215848019;5864.20833187519;5866.061430171173;5870.715344681403;5652.63257888237;5734.971325143369;5752.165935939286;5803.216565763621;5901.911471327933;5141.794328226866;5208.062548741225;5271.525562699357;5276.287701160351;5300.469953004688;277.17138583402254;5061.468545802693;5169.767360468769;5246.108161612516;5246.422893481714;5191.766370513336;5227.79088836446;5228.607854410896;5244.265802787632;5259.447757985395;5222.373315202162;5249.160134378481;5256.9737151314;5270.077736396115;5306.363236411656;4579.931301030487;5139.460356662534;5139.58883289336;5162.92255616166;5209.973950130263;5687.544996400319;5715.857103572403;5799.2750906136735;5833.358330583633;5854.151148083547;6119.4720884963735;6187.535934804908;6255.06174073888;6258.749650013994;6269.937300626981;6135.87580492187;6172.382761723837;6182.505399568069;6236.501079913596;6273.40402661751;5843.9707801461145;5857.033589457735;5860.765569377262;5864.912026319608;5906.911396328973;6171.352008039181;6215.378462153749;6334.714937827809;6349.746010159542;6379.585326953733;6114.214156512794;6135.171751813448;6153.876922461525;6172.444479996821;6240.344763799826;6123.989541725655;6221;6237.345078766664;6237.939550276464;6242.406971337716;6152.784652537229;6189.690515474208;6225;6225.097360882647;6251;6170.197874276315;6203.100550420164;6214.161088253028;6226.128342032119;6231.065340199007;4930.457649658535;4995.100881841231;4995.525425084611;5010.574101201366;5020.849374518771;4358.455193100863;4372.737635741865;4441.911161776747;4463.486699029589;4480.775961201927;5701.258836351248;5906.734196961147;5918.496927761188;5962.493188078975;5989.401059893976;5648.491635752802;6070.969645151746;6221.377862213742;6262.185915830913;6268.404501572343;4962.652614316963;5864.530837532987;5864.856353011121;5915.319738230072;5952.017917043726;5410.648307859977;5430.728463576885;5440.075187218183;5446.7276636168035;5475.479829416199;6362.681865906686;6379.075034120119;6383.585066970632;6384.170057892445;6398.4561312287115;6137.714085983886;6148.831721972811;6177.1969643945995;6180.7527698891545;6253.937460625518;5642.927843709682;6148.415900489446;6330.272018717722;6413.518986076157;6418.03729440569;6037.124616930432;6133.172021777003;6188.81433556994;6214.689265536615;6225.564210505221;6154.969225153845;6156.476699480415;6203.8138855834395;6240.28236752761;6240.313565507881;5954.166416701752;6088.178095957166;6096.496448835484;6123.63890065525;6136.140940268277;5074.782052307346;5756.338021127456;6053.4551890330085;6055.969720151371;6158.722857471335;4814.927776083432;5934.43622855828;5956.761729530944;6036.8188954331445;6038.879222415615;6071.483923866521;6094.51243900478;6131.938680613137;6137.938620613915;6143.508519318354;5798.739056742373;5912.940870591411;5975.16347711312;5978.581499295007;5985.670788106696 17:10:29 INFO - PROCESS | 1660 | |1;ext.html;471.2436539354336;486.19049282943877;509.5388673250707;549.8460431079297;587.8471597384679;38123.80938095309;40785.3882191767;40892.97767555805;41126.58873411265;41195;42156.57843421565;42947.14105717884;43001.924951876215;43123.13753724923;43123.70628881131;9516.524173791317;9606.9519652402;9713.222942164644;9714.757131071745;9726.756831079208;9671.129598336149;9699.70900872975;9730.270229732798;9742.707718768448;9772.31593788435;9619;9708.126268635822;9718.222542196643;9753.414795112316;9767.51162441875;9573.425594464354;9682.12860842524;9748.171405430547;9751.122398984126;9919.702408927744;9630.566624501915;9711.708648740549;9745.171660408874;9747.171490423323;9748.366356186825;40243.195136097114;40348;40608.78173654795;40633;40718.1856362874;3149.3386388858366;3377.4933759936207;3435.8282085895853;3442.2823350781096;3571.3035957988204;29688.40623187546;29812;30426.84786576053;30702.232444189074;32542.837285813657;3143.9528407073685;3160.873565057395;3164.430402527544;3192.952105718416;3285.293661862711;451104.7444762755;459616;461777;462300.68849655875;462306;34009.8096566619;34155.14612134716;34194.48708269378;34254.314913701586;34419.31161376758;34939;35495.4675679865;35554;35710.46434303487;36326;16788.91605541989;17067.06131162798;17104.315827367016;17214.913925430545;17232.052237126827;10859;11524.711882203012;12550.744925507377;13174.538891138764;13201.339933003312;19849.908255045822;20031.599368012558;20033.499162520762;20084.89957550203;20266.290679826136;6747.460203183734;8070.596470176468;8109.716159934492;8115.3913456491;8235.711750088718;724.8257822327863;959.4435227567993;1048.8531605575226;1060.55986765493;1123.2193625430248;29444.852775735984;31101.911433099733;31187.532187017212;31554;31700;1122.074288711816;1137.3630766770634;1152.9220179132371;1166.4634268236537;1215.7143071378218;15951.840481595267;16195.514134575982;16219.918900405422;16304.184790760415;16472.588185295463;625940;670140;702184;703946;705489;44917.77541112273;59429;60343.69828150831;60588;60665.393346066856;1387.6184049386297;1401.9228942408265;1403.480712136516;1418.581518452059;1424.0672359604682;30111.698883011766;30325;30332.393352132392;30692.23269418193;31030.68969310278;51340.486595135066;51907.74046129745;51986.96026079533;52074.47925520696;52100;578383;598792;600339;601715;602435;27049.323766905985;27260.454790903674;27606.447871042867;27611.30971725723;27692;48874.02251955012;49678.751606241734;49768;49991.75004124956;50554;40423.3936490947;40437.59562404338;40997.97505062397;41265.79367103145;41842.79078604587;34339.31321373609;41025.384619230135;41392.586074140076;41822.95442613959;42079.57920420756;32940.50589241115;38584;39236;39353.40969885397;39607.40588891227;28318.008869690286;33711.4943275856;34428.13929651779;36148;37319.067023324635;22461.179159730546;22490.5501889958;24562.877185613957;26433.074842380425;26554.867225664522 17:10:29 INFO - PROCESS | 1660 | |2;jquery.html;374.8613013185121;375.16712897367836;382.707228969838;389.91811719538896;396.2629509113051;19530;22398.216062437776;22654.43363915903;22694.65958010629;22780.88609556954;20253.797462025414;21236.04437800299;21246.25638102663;21288.254911078115;22248.887555622234;5511.751971161298;5564.443555644443;6215.036669316263;6230.844228894269;6235.407636274569;3872.341701910682;5809.302883653967;6044.274687037561;6174.876502469948;6181.0110382338835;6124.601900876429;6182.258129024501;6192.8451788705415;6212.471939885093;6230.345813689542;6193.442590166884;6225.066240063981;6228.844278893019;6231.813045608639;6238.937610623903;5738.982358828317;5890.823275301748;6019.608725432833;6054.303755068179;6064.120702498113;13571.796423053662;13629.863701362958;13648.65878353049;13689.520866769615;13734.931325343408;2178.575177840322;2376.7979721723673;2551.1836212412036;2707.4179051503825;2906.2443764621353;10205;10297.897021029768;10425.113865321457;10437.843432348522;14291.499797507142;1518.293993293124;1822.4259358302224;1827.8720489565735;1841.4107485604611;1911.9808801911943;99019.50490247575;124751;133197;133873.99189012172;135474;8928.553572321358;9567.665131720356;10070.345427547187;10952.233343665866;11831.408429578487;14772.630684232765;15009.399624014917;15014.699706005818;15022.023568468014;15055.849441505445;8606.87089693655;8683.652653893774;8769;8774.298056155492;8953.552322383855;8738.519381433955;8747.825043499222;8762.342824288204;8876.8668469973;8928.241099506486;4542.159700455426;4599.977000114978;4658.487566367697;4686.5782079613;4700.482946875841;1773.804881463038;1828.5112680392886;1923.7787654419642;1974.2004488182308;1974.8025197480424;794.4002278279862;889.4929889962789;956.4739393333639;973.5181085362649;998.6305067125065;22027.889860550917;22533.985970631362;22666.206682766355;22942.42643933915;22975.425614359774;982.3467394182932;999.6601155606983;1002.9247806414548;1031.5615863258085;1037.0355569320454;11491.942540287246;11881.5841445549;12030.699232519257;12041.939790301167;12072.698182545506;498511.07444627624;610930;618698;619072;638393;134096.3295183518;136788.31605842107;137501;139669.3016534931;139783.30108349392;960.188640598693;1023.2019025160387;1030.8093002794508;1035.1460045462522;1040.5265604150093;17540.649187015933;19809;20841.37475875726;20883.37349879506;21055.263065792624;40607.796961015;46805.76597116992;51931.74034129805;60650.180494585235;61727.69136154291;89343.10656893348;89778.65332020156;90463;91100;91191;8390.24487796077;8463.57682115904;8528.616212270339;8748.650053998024;8857.247133993682;13264.86735132675;13815.723685526435;14000.36998335057;14010.299485025504;14185.148891066568;11928.642140735792;11951.462184201906;12054.819177712518;12069.75860482803;12080.939595301967;11732.413379330828;11754.823677644672;11840.70398240051;11888.76222475563;11914.642560723192;12066.698332541757;12083.154179207371;12096.334701591144;12137.271763693854;12154.75690486203;8398.244158025807;8447.408681392244;8565.528895910784;8593.269572086443;8680;11577.363245021268;11922.225055371373;11998.700032499257;12059.69850753703;12123.75752484963 17:10:29 INFO - PROCESS | 1660 | |3;mootools.html;1395.8414515951758;1450.883929285657;1679.8152203257632;1719.1404297851075;1884.5288677830542;7859.685612575505;8381.748547543568;8532.616032278547;8877.112288771119;8900.732978010661;7329.486935914488;8540.402171847973;8661.177188167114;8731.825363492726;8744;2134.114342547841;2152.5587254612847;2163;2164.145162660756;2164.545445456456;2041.9795802042013;2315.8842057897036;2338.1816364272454;2365.042157926034;2378.4291769975166;2323.2217207235512;2329.3477826208687;2348.518553696488;2367.502824406868;2380.809535237177;1956.178405069874;2298.6207275799475;2304.8847557622053;2309.191782875997;2311.133325003124;2314.2247347138727;2316.8841557922037;2326.8487548309304;2329.7903188712926;2347.448349637834;8802.603882825224;8915.197632213067;8915.687950921687;8923.955380223057;8932.464052156827;5175.120229560984;5261.76322065508;5324.361076670824;5324.494173053554;5344.43883392246;3422.4866270059692;3538.115471132217;3595.3281723998466;3606.9098272543133;3628.600853906068;920.7018104472661;1041.9166466682648;1069.7593041565585;1074.752806854428;1089.4280502736049;11221.551137954471;11352.943235283854;11360.715982100513;11362.431878406129;11416.687080985794;4134.875953721393;4542.409486766699;4556.11155824611;4749.596284315872;4757.595604373598;9692.70921872345;9725.805483890425;9727.221822254203;9737.367071140354;9763.804723905481;5265.104932161542;5325.920111198335;5342.91985620216;5350.9732451337495;5356.7321633918145;4400.361947517656;4679.9298010529865;4812.711237325771;4897.142999975062;4901.485344038896;3959.7822119783687;3966.603339666068;4001.419794129893;4033.616806403387;4105.055837157471;1266.645339304996;1302.2772361339548;1303.0162227518163;1317.4532568983764;1330.2085259270718;857.4374021133666;928.5310917986374;931.2503434734967;937.2689302344182;944.6268723854039;5780.710964451845;5869.442402971797;5938.736509108677;5957.285125784933;6052.12244224585;424.2279052125164;428.1714881703913;432.9523752387235;435.81477871904946;453.22724754293847;3433.5193072969805;3944.8027598619956;4027.1744292419985;4091.8567850125696;4108.856190033334;10044.598216071276;10058.396496210251;10280.434576098387;10394.324368915995;10420.739481513023;9099.681511147079;10204;10384.273100883016;10390.376577405379;10416.843747343795;7912.920870791334;7919.366450683931;7987.1613480584865;8034.678612855537;8112.067112282163;5806.647095931313;5868.530517558671;5883.441073098049;5910.556708246812;5959.255093113361;9484.288678349289;9739.659111931049;9754.414735115915;9756.658516951873;9758.316917815968;9697.757556061155;9860.457674827954;9882.160016398686;9910.752231194278;9947.950260248652;6239.376062393724;7387.1135463744695;7406.481546291708;7480.738174163878;7503.1746507883;7965.163657815846;8034.076081250497;8058.959705201437;8105.189481051848;8119.715809946623;7247.057882475245;7322.816929576803;7378.151512575908;7491.250874912683;7502.737404190827;7187.9640601796655;7267.963660181666;7280.907863820257;7349.963250183929;7371.668274927534;5781.82654520365;5840.269966254218;5961.493273071837;6644.704282664834;6881.10545629085;4920.630952678635;4943.209086546135;4984.675996060245;4986.750662466935;5059.139946209227;4993.525615066563;5059.418166910852;5122.078025955364;5148.665336753099;5212.400573934046 17:10:29 INFO - PROCESS | 1660 | |4;prototype.html;278.4597880112581;301.4769375134142;315.4904828701647;318.10136364769534;320.2538086259017;5667;5677.460641239086;5743.052396354597;5867.765289388425;5881.411858814122;5731.598788084836;5772.989726797815;5780.219670344502;5786.074228123501;5798.565107616935;3593.9820300898523;4351.434313539251;4358.673099517533;4389.4513185851765;4394.912101757963;3787.080371815172;3807.2195199983935;4341.327094300388;4393.406890069848;4428.645708343341;3528.9470657940024;3771.641694039062;4274.658027357819;4313.805878735465;4346.695731298811;3601.405768048269;3621.674049335546;4307.332363483665;4323.762193079379;4345.847895323648;3413.8805141819917;3734.9813250933844;3743.3262012837677;3749.4000959846294;3766.1753684736445;4392.9676526016365;5228.2680424740565;5646.407127251661;5648.491635752802;5724.341700704431;4849.345338379344;4929.334539837112;4937.308776771255;4958.925616115761;4978.103941290567;5285.524302812765;5612.438756124396;5941.316748573883;5977.820665380045;6158.599691020069;3979.641832235113;4016.136530645925;4040.1919616076902;4041.7979101045125;4059.3302105152616;6366.968165159191;6378.744850205986;6423.903641445382;6431.0031945048595;6453.419192272718;3992.441058251847;4098.221337945781;4104.015036391244;4104.4664193654635;4121.9381709274385;4138.91722165555;4152.480939882515;4154.356074808409;4177.26897792885;4200.810963506588;4345.956540434619;4703.623710103184;4949.678270912451;4966.553010229024;4977.925331120036;4750.857474275777;5020.941414020234;5069.594432445396;5416.322959630046;6063.181470501426;1453.324204245031;1477.3130494319978;1486.0637798187072;1493.939303094793;1494.140869000329;721.0266140709999;906.6962567539816;914.7255823252998;919.8068405634891;931.8322701913585;4238.851640192578;4592.563706447882;4760.309755085494;4783.856484305476;4798.832040878622;4842.806287748451;4848.5636292733825;4954.504549545017;5291.894162116736;5399.649022813504;4317.222899877989;4418.712783669115;4437.889052773707;4645.814167433333;4864.489228631013;2319.814414846808;2360.811135109187;2438.3416477550963;2814.5356016257088;2825.615448430254;4685.718856868599;5385.919211211835;5480.780768769284;5541.944580554143;5564.304461942257;4927.802887884516;5435.374931882805;5452.591055670761;5472.945270547243;5502.202180683778;5402.837914862561;5508.338999320107;5526.364468086222;5560.77756889728;5597.997431836094;4633.953660463352;4669.136209801198;5347.385050719217;5366.275552800478;5411.918821217763;5272.947270527399;5300.761465733974;5607.775688972395;5851.414858514115;5994.920914235305;5682.801101961411;5978.461938425563;6547.476201903741;6612.603243805387;6632.369924857131;4085.895763681766;4087.5708050654252;4087.5912408758886;4113.876583702494;4121.4848143982;5194.610404219623;5361.35663720356;6064.514838812973;6221.813345599639;6261.090367437975;5098.5411312982005;5313.299744081856;6025.8192254232445;6047.9395206047375;6082.840591589922;6054.455099041107;6093.329733729198;6137;6137.956547386866;6177.96911015442;5439.972800135974;5466.326291021279;5652.523697925664;5913.201717768046;5997.970010149921;6013.819585412444;6086.72609732572;6130.877382452415;6131.662758548323;6158.753649853956;4610.386364772303;5407.270018547446;5479.287692599936;5849.210356601804;5906.40935906406 17:10:29 INFO - PROCESS | 1660 | |5;yui.html;596.3201949777254;706.6643344411403;770.4260326057084;790.2097902097902;820.9220124088209;15087.245637718112;15285.235738213101;15766.60583485412;15789.131597762118;15817.209139543005;14467.927660361684;14482.131072135653;14551.636209094751;14596.562103136896;14608.634784130401;720.5424555407302;892.2282225874604;892.5849479991803;906.4923642760042;911.1162172692477;877.0440220160025;879.3712495565669;888.6489836514573;919.880415545978;924.1359329027347;947.8957314695378;982.346739418286;982.4301904895144;985.6106837799065;986.9013098690109;960.6829746183778;976.3604838830541;976.8827740671094;979.4661909259471;980.8577756225308;684.7603338831419;686.4885660183146;720.9279072092748;721.5346101764385;721.95307305025;15302.081875087419;15486.380544778196;15509.767353489706;15548.689026219525;15555.144467054308;14970.925145374204;15029.098254104789;15035.624109397244;15129.243537823066;15250.847491525054;11010.449477526092;11086.833697494543;11225.887741122566;11352.886471135265;11427.371494567795;3983.083890705154;4033.9394909076386;4080.551139374696;4087.713860029799;4093.713440059197;122744;124633.13050304343;125345.74654253523;125831;126426;11607.825882611767;11650.30098194111;11655.242409243541;11830.408479575986;11871.465784039567;19796.604067918848;22928.656070158962;23000.769992300196;24218.87890560571;24309.027638894248;7667.616619169019;7928.5909644695985;8095.23095305945;8301.46040507365;8454.450460720034;4491.977540112279;4532.297493888453;4545.931811022837;4616.930746038812;4630.097131059411;3510.2452972611013;3539.150603855108;3544.8227588620466;3586.6951309138494;3643.708503319781;680.6664734280167;682.6382017530717;683.2893790457967;685.3934268172603;690.9101816763789;496.7541067171773;607.6293460988793;610.9816705498843;616.2358675242667;649.422014407178;8752.47485150893;8854.822903541894;8889;9133.49765762876;9283.39657922233;540.7999040355094;610.6275172144988;622.17561730707;686.114911763829;700.4606453031138;3546.432570788713;4371.868843934687;4557.384753058361;4617.353570500132;4690.7654617269;148770.25614871856;153116;153274;154459;156446;82547;93960.53019734858;114415;122132.38933805274;123457;84788;99091.00908990818;105047;106420.46789766001;110816;9453.480058596842;9583.808323833624;9672.177864881283;9782.657606983721;9876.851847222153;57524.84950301054;61062.38937610567;61459;62662;62922.37077629165;79807;82782;89069.55465222632;89941;90772.54613727154;12824.615261542169;13294.734105318033;13476.460941562227;13575.049746517649;14077.94415418868;14374.065685730395;14388.35252413623;14652.560423187322;14898.627534311729;14969.401223951356;13136.5549789525;13432.19406835593;13528.59414217575;13564.93217533906;13671;13199.802002970155;13300.135491193041;13387.598372048855;13435.19388836673;13442.596722098353;12885.871141288468;12919.612411627666;13118.900975843819;13236.404361803548;13297.401616927067;11165.05097066726;11235.943820280847;11489.942550287195;11744.58893938708;11840;10763.461826908466;11343.20597558163;11454.112038140776;11532.481038353462;11648.359340236368 17:10:29 INFO - PROCESS | 1660 | __end_tp_report 17:10:29 INFO - PROCESS | 1660 | __start_cc_report 17:10:29 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,440 17:10:29 INFO - PROCESS | 1660 | __end_cc_report 17:10:29 INFO - PROCESS | 1660 | __startTimestamp1467677429477__endTimestamp 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | ------- Summary: start ------- 17:10:29 INFO - PROCESS | 1660 | Number of tests: 6 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | [#0] dojo.html Cycles:165 Average:5711.66 Median:5956.76 stddev:768.11 (12.9%) stddev-sans-first:748.29 17:10:29 INFO - PROCESS | 1660 | Values: 3375.9 3379.6 3399.0 3404.7 3405.9 5729.7 5814.3 5864.2 5866.1 5870.7 5652.6 5735.0 5752.2 5803.2 5901.9 5141.8 5208.1 5271.5 5276.3 5300.5 277.2 5061.5 5169.8 5246.1 5246.4 5191.8 5227.8 5228.6 5244.3 5259.4 5222.4 5249.2 5257.0 5270.1 5306.4 4579.9 5139.5 5139.6 5162.9 5210.0 5687.5 5715.9 5799.3 5833.4 5854.2 6119.5 6187.5 6255.1 6258.7 6269.9 6135.9 6172.4 6182.5 6236.5 6273.4 5844.0 5857.0 5860.8 5864.9 5906.9 6171.4 6215.4 6334.7 6349.7 6379.6 6114.2 6135.2 6153.9 6172.4 6240.3 6124.0 6221.0 6237.3 6237.9 6242.4 6152.8 6189.7 6225.0 6225.1 6251.0 6170.2 6203.1 6214.2 6226.1 6231.1 4930.5 4995.1 4995.5 5010.6 5020.8 4358.5 4372.7 4441.9 4463.5 4480.8 5701.3 5906.7 5918.5 5962.5 5989.4 5648.5 6071.0 6221.4 6262.2 6268.4 4962.7 5864.5 5864.9 5915.3 5952.0 5410.6 5430.7 5440.1 5446.7 5475.5 6362.7 6379.1 6383.6 6384.2 6398.5 6137.7 6148.8 6177.2 6180.8 6253.9 5642.9 6148.4 6330.3 6413.5 6418.0 6037.1 6133.2 6188.8 6214.7 6225.6 6155.0 6156.5 6203.8 6240.3 6240.3 5954.2 6088.2 6096.5 6123.6 6136.1 5074.8 5756.3 6053.5 6056.0 6158.7 4814.9 5934.4 5956.8 6036.8 6038.9 6071.5 6094.5 6131.9 6137.9 6143.5 5798.7 5912.9 5975.2 5978.6 5985.7 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | [#1] ext.html Cycles:180 Average:69987.90 Median:40295.60 stddev:157110.81 (389.9%) stddev-sans-first:157464.85 17:10:29 INFO - PROCESS | 1660 | Values: 471.2 486.2 509.5 549.8 587.8 38123.8 40785.4 40893.0 41126.6 41195.0 42156.6 42947.1 43001.9 43123.1 43123.7 9516.5 9607.0 9713.2 9714.8 9726.8 9671.1 9699.7 9730.3 9742.7 9772.3 9619.0 9708.1 9718.2 9753.4 9767.5 9573.4 9682.1 9748.2 9751.1 9919.7 9630.6 9711.7 9745.2 9747.2 9748.4 40243.2 40348.0 40608.8 40633.0 40718.2 3149.3 3377.5 3435.8 3442.3 3571.3 29688.4 29812.0 30426.8 30702.2 32542.8 3144.0 3160.9 3164.4 3193.0 3285.3 451104.7 459616.0 461777.0 462300.7 462306.0 34009.8 34155.1 34194.5 34254.3 34419.3 34939.0 35495.5 35554.0 35710.5 36326.0 16788.9 17067.1 17104.3 17214.9 17232.1 10859.0 11524.7 12550.7 13174.5 13201.3 19849.9 20031.6 20033.5 20084.9 20266.3 6747.5 8070.6 8109.7 8115.4 8235.7 724.8 959.4 1048.9 1060.6 1123.2 29444.9 31101.9 31187.5 31554.0 31700.0 1122.1 1137.4 1152.9 1166.5 1215.7 15951.8 16195.5 16219.9 16304.2 16472.6 625940.0 670140.0 702184.0 703946.0 705489.0 44917.8 59429.0 60343.7 60588.0 60665.4 1387.6 1401.9 1403.5 1418.6 1424.1 30111.7 30325.0 30332.4 30692.2 31030.7 51340.5 51907.7 51987.0 52074.5 52100.0 578383.0 598792.0 600339.0 601715.0 602435.0 27049.3 27260.5 27606.4 27611.3 27692.0 48874.0 49678.8 49768.0 49991.8 50554.0 40423.4 40437.6 40998.0 41265.8 41842.8 34339.3 41025.4 41392.6 41823.0 42079.6 32940.5 38584.0 39236.0 39353.4 39607.4 28318.0 33711.5 34428.1 36148.0 37319.1 22461.2 22490.6 24562.9 26433.1 26554.9 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | [#2] jquery.html Cycles:180 Average:35863.97 Median:22680.43 stddev:100621.70 (443.6%) stddev-sans-first:100868.69 17:10:29 INFO - PROCESS | 1660 | Values: 374.9 375.2 382.7 389.9 396.3 19530.0 22398.2 22654.4 22694.7 22780.9 20253.8 21236.0 21246.3 21288.3 22248.9 5511.8 5564.4 6215.0 6230.8 6235.4 3872.3 5809.3 6044.3 6174.9 6181.0 6124.6 6182.3 6192.8 6212.5 6230.3 6193.4 6225.1 6228.8 6231.8 6238.9 5739.0 5890.8 6019.6 6054.3 6064.1 13571.8 13629.9 13648.7 13689.5 13734.9 2178.6 2376.8 2551.2 2707.4 2906.2 10205.0 10297.9 10425.1 10437.8 14291.5 1518.3 1822.4 1827.9 1841.4 1912.0 99019.5 124751.0 133197.0 133874.0 135474.0 8928.6 9567.7 10070.3 10952.2 11831.4 14772.6 15009.4 15014.7 15022.0 15055.8 8606.9 8683.7 8769.0 8774.3 8953.6 8738.5 8747.8 8762.3 8876.9 8928.2 4542.2 4600.0 4658.5 4686.6 4700.5 1773.8 1828.5 1923.8 1974.2 1974.8 794.4 889.5 956.5 973.5 998.6 22027.9 22534.0 22666.2 22942.4 22975.4 982.3 999.7 1002.9 1031.6 1037.0 11491.9 11881.6 12030.7 12041.9 12072.7 498511.1 610930.0 618698.0 619072.0 638393.0 134096.3 136788.3 137501.0 139669.3 139783.3 960.2 1023.2 1030.8 1035.1 1040.5 17540.6 19809.0 20841.4 20883.4 21055.3 40607.8 46805.8 51931.7 60650.2 61727.7 89343.1 89778.7 90463.0 91100.0 91191.0 8390.2 8463.6 8528.6 8748.7 8857.2 13264.9 13815.7 14000.4 14010.3 14185.1 11928.6 11951.5 12054.8 12069.8 12080.9 11732.4 11754.8 11840.7 11888.8 11914.6 12066.7 12083.2 12096.3 12137.3 12154.8 8398.2 8447.4 8565.5 8593.3 8680.0 11577.4 11922.2 11998.7 12059.7 12123.8 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | [#3] mootools.html Cycles:180 Average:5580.55 Median:5135.37 stddev:3115.84 (60.7%) stddev-sans-first:3108.70 17:10:29 INFO - PROCESS | 1660 | Values: 1395.8 1450.9 1679.8 1719.1 1884.5 7859.7 8381.7 8532.6 8877.1 8900.7 7329.5 8540.4 8661.2 8731.8 8744.0 2134.1 2152.6 2163.0 2164.1 2164.5 2042.0 2315.9 2338.2 2365.0 2378.4 2323.2 2329.3 2348.5 2367.5 2380.8 1956.2 2298.6 2304.9 2309.2 2311.1 2314.2 2316.9 2326.8 2329.8 2347.4 8802.6 8915.2 8915.7 8924.0 8932.5 5175.1 5261.8 5324.4 5324.5 5344.4 3422.5 3538.1 3595.3 3606.9 3628.6 920.7 1041.9 1069.8 1074.8 1089.4 11221.6 11352.9 11360.7 11362.4 11416.7 4134.9 4542.4 4556.1 4749.6 4757.6 9692.7 9725.8 9727.2 9737.4 9763.8 5265.1 5325.9 5342.9 5351.0 5356.7 4400.4 4679.9 4812.7 4897.1 4901.5 3959.8 3966.6 4001.4 4033.6 4105.1 1266.6 1302.3 1303.0 1317.5 1330.2 857.4 928.5 931.3 937.3 944.6 5780.7 5869.4 5938.7 5957.3 6052.1 424.2 428.2 433.0 435.8 453.2 3433.5 3944.8 4027.2 4091.9 4108.9 10044.6 10058.4 10280.4 10394.3 10420.7 9099.7 10204.0 10384.3 10390.4 10416.8 7912.9 7919.4 7987.2 8034.7 8112.1 5806.6 5868.5 5883.4 5910.6 5959.3 9484.3 9739.7 9754.4 9756.7 9758.3 9697.8 9860.5 9882.2 9910.8 9948.0 6239.4 7387.1 7406.5 7480.7 7503.2 7965.2 8034.1 8059.0 8105.2 8119.7 7247.1 7322.8 7378.2 7491.3 7502.7 7188.0 7268.0 7280.9 7350.0 7371.7 5781.8 5840.3 5961.5 6644.7 6881.1 4920.6 4943.2 4984.7 4986.8 5059.1 4993.5 5059.4 5122.1 5148.7 5212.4 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | [#4] prototype.html Cycles:180 Average:4670.13 Median:5045.27 stddev:1450.93 (28.8%) stddev-sans-first:1417.06 17:10:29 INFO - PROCESS | 1660 | Values: 278.5 301.5 315.5 318.1 320.3 5667.0 5677.5 5743.1 5867.8 5881.4 5731.6 5773.0 5780.2 5786.1 5798.6 3594.0 4351.4 4358.7 4389.5 4394.9 3787.1 3807.2 4341.3 4393.4 4428.6 3528.9 3771.6 4274.7 4313.8 4346.7 3601.4 3621.7 4307.3 4323.8 4345.8 3413.9 3735.0 3743.3 3749.4 3766.2 4393.0 5228.3 5646.4 5648.5 5724.3 4849.3 4929.3 4937.3 4958.9 4978.1 5285.5 5612.4 5941.3 5977.8 6158.6 3979.6 4016.1 4040.2 4041.8 4059.3 6367.0 6378.7 6423.9 6431.0 6453.4 3992.4 4098.2 4104.0 4104.5 4121.9 4138.9 4152.5 4154.4 4177.3 4200.8 4346.0 4703.6 4949.7 4966.6 4977.9 4750.9 5020.9 5069.6 5416.3 6063.2 1453.3 1477.3 1486.1 1493.9 1494.1 721.0 906.7 914.7 919.8 931.8 4238.9 4592.6 4760.3 4783.9 4798.8 4842.8 4848.6 4954.5 5291.9 5399.6 4317.2 4418.7 4437.9 4645.8 4864.5 2319.8 2360.8 2438.3 2814.5 2825.6 4685.7 5385.9 5480.8 5541.9 5564.3 4927.8 5435.4 5452.6 5472.9 5502.2 5402.8 5508.3 5526.4 5560.8 5598.0 4634.0 4669.1 5347.4 5366.3 5411.9 5272.9 5300.8 5607.8 5851.4 5994.9 5682.8 5978.5 6547.5 6612.6 6632.4 4085.9 4087.6 4087.6 4113.9 4121.5 5194.6 5361.4 6064.5 6221.8 6261.1 5098.5 5313.3 6025.8 6047.9 6082.8 6054.5 6093.3 6137.0 6138.0 6178.0 5440.0 5466.3 5652.5 5913.2 5998.0 6013.8 6086.7 6130.9 6131.7 6158.8 4610.4 5407.3 5479.3 5849.2 5906.4 17:10:29 INFO - PROCESS | 1660 | 17:10:29 INFO - PROCESS | 1660 | [#5] yui.html Cycles:180 Average:24500.34 Median:3615.20 stddev:38856.97 (1074.8%) stddev-sans-first:38924.52 17:10:29 INFO - PROCESS | 1660 | Values: 596.3 706.7 770.4 790.2 820.9 15087.2 15285.2 15766.6 15789.1 15817.2 14467.9 14482.1 14551.6 14596.6 14608.6 720.5 892.2 892.6 906.5 911.1 877.0 879.4 888.6 919.9 924.1 947.9 982.3 982.4 985.6 986.9 960.7 976.4 976.9 979.5 980.9 684.8 686.5 720.9 721.5 722.0 15302.1 15486.4 15509.8 15548.7 15555.1 14970.9 15029.1 15035.6 15129.2 15250.8 11010.4 11086.8 11225.9 11352.9 11427.4 3983.1 4033.9 4080.6 4087.7 4093.7 122744.0 124633.1 125345.7 125831.0 126426.0 11607.8 11650.3 11655.2 11830.4 11871.5 19796.6 22928.7 23000.8 24218.9 24309.0 7667.6 7928.6 8095.2 8301.5 8454.5 4492.0 4532.3 4545.9 4616.9 4630.1 3510.2 3539.2 3544.8 3586.7 3643.7 680.7 682.6 683.3 685.4 690.9 496.8 607.6 611.0 616.2 649.4 8752.5 8854.8 8889.0 9133.5 9283.4 540.8 610.6 622.2 686.1 700.5 3546.4 4371.9 4557.4 4617.4 4690.8 148770.3 153116.0 153274.0 154459.0 156446.0 82547.0 93960.5 114415.0 122132.4 123457.0 84788.0 99091.0 105047.0 106420.5 110816.0 9453.5 9583.8 9672.2 9782.7 9876.9 57524.8 61062.4 61459.0 62662.0 62922.4 79807.0 82782.0 89069.6 89941.0 90772.5 12824.6 13294.7 13476.5 13575.0 14077.9 14374.1 14388.4 14652.6 14898.6 14969.4 13136.6 13432.2 13528.6 13564.9 13671.0 13199.8 13300.1 13387.6 13435.2 13442.6 12885.9 12919.6 13118.9 13236.4 13297.4 11165.1 11235.9 11489.9 11744.6 11840.0 10763.5 11343.2 11454.1 11532.5 11648.4 17:10:29 INFO - PROCESS | 1660 | -------- Summary: end -------- 17:10:29 INFO - PROCESS | 1660 | 17:10:30 INFO - TEST-INFO | 1660: exit 0 17:10:30 INFO - TEST-OK | dromaeo_css | took 1112498ms 17:10:30 INFO - TEST-START | kraken 17:10:30 INFO - operating with platform_type : mac_ 17:10:30 INFO - Initialising browser for kraken test... 17:10:30 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpfsRdSS/profile http://localhost:49288/getInfo.html) 17:10:33 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 17:10:33 INFO - PROCESS | 1668 | colorDepth:24 17:10:33 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 17:10:33 INFO - PROCESS | 1668 | __metrics 17:10:33 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 17:10:34 INFO - TEST-INFO | 1668: exit 0 17:10:34 INFO - Browser initialized. 17:10:34 INFO - Running cycle 1/1 for kraken test... 17:10:34 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/T/tmpfsRdSS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:46 INFO - PROCESS | 1670 | RSS: Main: 255668224 17:10:46 INFO - PROCESS | 1670 | 17:10:48 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:50 INFO - PROCESS | 1670 | RSS: Main: 268328960 17:10:50 INFO - PROCESS | 1670 | 17:10:52 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-dft) 17:10:53 INFO - PROCESS | 1670 | RSS: Main: 272879616 17:10:53 INFO - PROCESS | 1670 | 17:10:56 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-fft) 17:10:57 INFO - PROCESS | 1670 | RSS: Main: 272879616 17:10:57 INFO - PROCESS | 1670 | 17:10:59 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator) 17:10:59 INFO - PROCESS | 1670 | RSS: Main: 273870848 17:10:59 INFO - PROCESS | 1670 | 17:11:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:11:02 INFO - PROCESS | 1670 | RSS: Main: 274522112 17:11:02 INFO - PROCESS | 1670 | 17:11:05 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom) 17:11:05 INFO - PROCESS | 1670 | RSS: Main: 275378176 17:11:05 INFO - PROCESS | 1670 | 17:11:08 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate) 17:11:09 INFO - PROCESS | 1670 | RSS: Main: 275529728 17:11:09 INFO - PROCESS | 1670 | 17:11:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial) 17:11:13 INFO - PROCESS | 1670 | RSS: Main: 275562496 17:11:13 INFO - PROCESS | 1670 | 17:11:14 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:11:15 INFO - PROCESS | 1670 | RSS: Main: 275427328 17:11:15 INFO - PROCESS | 1670 | 17:11:17 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:11:18 INFO - PROCESS | 1670 | RSS: Main: 274927616 17:11:18 INFO - PROCESS | 1670 | 17:11:20 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:11:20 INFO - PROCESS | 1670 | RSS: Main: 275267584 17:11:20 INFO - PROCESS | 1670 | 17:11:23 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:11:24 INFO - PROCESS | 1670 | RSS: Main: 275480576 17:11:24 INFO - PROCESS | 1670 | 17:11:27 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:11:27 INFO - PROCESS | 1670 | RSS: Main: 275415040 17:11:27 INFO - PROCESS | 1670 | 17:11:29 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49288/tests/kraken/driver.html?testName=ai-astar) 17:11:30 INFO - PROCESS | 1670 | RSS: Main: 276385792 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | __start_tp_report 17:11:30 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 17:11:30 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 17:11:30 INFO - PROCESS | 1670 | |i|pagename|runs| 17:11:30 INFO - PROCESS | 1670 | |0;ai-astar;120;121;127;167;173;115;114;121;171;112 17:11:30 INFO - PROCESS | 1670 | |1;audio-beat-detection;143;108;133;150;96;118;150;143;197;109 17:11:30 INFO - PROCESS | 1670 | |2;audio-dft;196;201;213;216;196;200;197;195;201;197 17:11:30 INFO - PROCESS | 1670 | |3;audio-fft;70;82;75;144;85;69;59;61;134;76 17:11:30 INFO - PROCESS | 1670 | |4;audio-oscillator;68;69;118;70;72;101;112;70;71;114 17:11:30 INFO - PROCESS | 1670 | |5;imaging-gaussian-blur;128;88;90;87;90;88;91;89;91;88 17:11:30 INFO - PROCESS | 1670 | |6;imaging-darkroom;103;96;97;99;96;108;97;155;99;102 17:11:30 INFO - PROCESS | 1670 | |7;imaging-desaturate;92;95;100;149;147;101;151;125;92;113 17:11:30 INFO - PROCESS | 1670 | |8;json-parse-financial;58;57;58;56;57;59;55;58;58;57 17:11:30 INFO - PROCESS | 1670 | |9;json-stringify-tinderbox;67;70;77;81;81;77;75;72;72;71 17:11:30 INFO - PROCESS | 1670 | |10;stanford-crypto-aes;87;85;83;85;85;84;85;82;89;85 17:11:30 INFO - PROCESS | 1670 | |11;stanford-crypto-ccm;140;156;153;159;156;125;156;150;245;140 17:11:30 INFO - PROCESS | 1670 | |12;stanford-crypto-pbkdf2;164;171;163;167;166;172;163;169;163;166 17:11:30 INFO - PROCESS | 1670 | |13;stanford-crypto-sha256-iterative;69;79;62;61;72;86;85;89;91;90 17:11:30 INFO - PROCESS | 1670 | __end_tp_report 17:11:30 INFO - PROCESS | 1670 | __start_cc_report 17:11:30 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,1118 17:11:30 INFO - PROCESS | 1670 | __end_cc_report 17:11:30 INFO - PROCESS | 1670 | __startTimestamp1467677490017__endTimestamp 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | ------- Summary: start ------- 17:11:30 INFO - PROCESS | 1670 | Number of tests: 14 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#0] ai-astar Cycles:10 Average:134.10 Median:124.00 stddev:25.40 (20.5%) stddev-sans-first:26.42 17:11:30 INFO - PROCESS | 1670 | Values: 120.0 121.0 127.0 167.0 173.0 115.0 114.0 121.0 171.0 112.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:146.50 stddev:29.14 (19.9%) stddev-sans-first:30.75 17:11:30 INFO - PROCESS | 1670 | Values: 143.0 108.0 133.0 150.0 96.0 118.0 150.0 143.0 197.0 109.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#2] audio-dft Cycles:10 Average:201.20 Median:200.50 stddev:7.36 (3.7%) stddev-sans-first:7.56 17:11:30 INFO - PROCESS | 1670 | Values: 196.0 201.0 213.0 216.0 196.0 200.0 197.0 195.0 201.0 197.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#3] audio-fft Cycles:10 Average:85.50 Median:72.50 stddev:29.44 (40.6%) stddev-sans-first:30.69 17:11:30 INFO - PROCESS | 1670 | Values: 70.0 82.0 75.0 144.0 85.0 69.0 59.0 61.0 134.0 76.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:69.50 stddev:21.74 (31.3%) stddev-sans-first:22.00 17:11:30 INFO - PROCESS | 1670 | Values: 68.0 69.0 118.0 70.0 72.0 101.0 112.0 70.0 71.0 114.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:89.50 stddev:12.37 (13.8%) stddev-sans-first:1.45 17:11:30 INFO - PROCESS | 1670 | Values: 128.0 88.0 90.0 87.0 90.0 88.0 91.0 89.0 91.0 88.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#6] imaging-darkroom Cycles:10 Average:105.20 Median:96.50 stddev:17.90 (18.5%) stddev-sans-first:18.97 17:11:30 INFO - PROCESS | 1670 | Values: 103.0 96.0 97.0 99.0 96.0 108.0 97.0 155.0 99.0 102.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#7] imaging-desaturate Cycles:10 Average:116.50 Median:150.00 stddev:24.58 (16.4%) stddev-sans-first:24.42 17:11:30 INFO - PROCESS | 1670 | Values: 92.0 95.0 100.0 149.0 147.0 101.0 151.0 125.0 92.0 113.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:58.00 stddev:1.16 (2.0%) stddev-sans-first:1.20 17:11:30 INFO - PROCESS | 1670 | Values: 58.0 57.0 58.0 56.0 57.0 59.0 55.0 58.0 58.0 57.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#9] json-stringify-tinderbox Cycles:10 Average:74.30 Median:76.00 stddev:4.69 (6.2%) stddev-sans-first:4.17 17:11:30 INFO - PROCESS | 1670 | Values: 67.0 70.0 77.0 81.0 81.0 77.0 75.0 72.0 72.0 71.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.94 (2.3%) stddev-sans-first:1.92 17:11:30 INFO - PROCESS | 1670 | Values: 87.0 85.0 83.0 85.0 85.0 84.0 85.0 82.0 89.0 85.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#11] stanford-crypto-ccm Cycles:10 Average:158.00 Median:156.00 stddev:32.33 (20.7%) stddev-sans-first:33.63 17:11:30 INFO - PROCESS | 1670 | Values: 140.0 156.0 153.0 159.0 156.0 125.0 156.0 150.0 245.0 140.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.50 stddev:3.34 (2.0%) stddev-sans-first:3.43 17:11:30 INFO - PROCESS | 1670 | Values: 164.0 171.0 163.0 167.0 166.0 172.0 163.0 169.0 163.0 166.0 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - PROCESS | 1670 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.40 Median:85.50 stddev:11.59 (13.6%) stddev-sans-first:11.78 17:11:30 INFO - PROCESS | 1670 | Values: 69.0 79.0 62.0 61.0 72.0 86.0 85.0 89.0 91.0 90.0 17:11:30 INFO - PROCESS | 1670 | -------- Summary: end -------- 17:11:30 INFO - PROCESS | 1670 | 17:11:30 INFO - TEST-INFO | 1670: exit 0 17:11:30 INFO - TEST-OK | kraken | took 60598ms 17:11:30 INFO - SUITE-END | took 1173s 17:11:31 INFO - Completed test suite (00:19:33) 17:11:31 INFO - javascript benchmark 17:11:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7377.908310182744, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3375.932481350373, 3379.6451372605893, 3399.0, 3404.710599599034, 3405.9489107663376, 5729.656220626765, 5814.273215848019, 5864.20833187519, 5866.061430171173, 5870.715344681403, 5652.63257888237, 5734.971325143369, 5752.165935939286, 5803.216565763621, 5901.911471327933, 5141.794328226866, 5208.062548741225, 5271.525562699357, 5276.287701160351, 5300.469953004688, 277.17138583402254, 5061.468545802693, 5169.767360468769, 5246.108161612516, 5246.422893481714, 5191.766370513336, 5227.79088836446, 5228.607854410896, 5244.265802787632, 5259.447757985395, 5222.373315202162, 5249.160134378481, 5256.9737151314, 5270.077736396115, 5306.363236411656, 4579.931301030487, 5139.460356662534, 5139.58883289336, 5162.92255616166, 5209.973950130263, 5687.544996400319, 5715.857103572403, 5799.2750906136735, 5833.358330583633, 5854.151148083547, 6119.4720884963735, 6187.535934804908, 6255.06174073888, 6258.749650013994, 6269.937300626981, 6135.87580492187, 6172.382761723837, 6182.505399568069, 6236.501079913596, 6273.40402661751, 5843.9707801461145, 5857.033589457735, 5860.765569377262, 5864.912026319608, 5906.911396328973, 6171.352008039181, 6215.378462153749, 6334.714937827809, 6349.746010159542, 6379.585326953733, 6114.214156512794, 6135.171751813448, 6153.876922461525, 6172.444479996821, 6240.344763799826, 6123.989541725655, 6221.0, 6237.345078766664, 6237.939550276464, 6242.406971337716, 6152.784652537229, 6189.690515474208, 6225.0, 6225.097360882647, 6251.0, 6170.197874276315, 6203.100550420164, 6214.161088253028, 6226.128342032119, 6231.065340199007, 4930.457649658535, 4995.100881841231, 4995.525425084611, 5010.574101201366, 5020.849374518771, 4358.455193100863, 4372.737635741865, 4441.911161776747, 4463.486699029589, 4480.775961201927, 5701.258836351248, 5906.734196961147, 5918.496927761188, 5962.493188078975, 5989.401059893976, 5648.491635752802, 6070.969645151746, 6221.377862213742, 6262.185915830913, 6268.404501572343, 4962.652614316963, 5864.530837532987, 5864.856353011121, 5915.319738230072, 5952.017917043726, 5410.648307859977, 5430.728463576885, 5440.075187218183, 5446.7276636168035, 5475.479829416199, 6362.681865906686, 6379.075034120119, 6383.585066970632, 6384.170057892445, 6398.4561312287115, 6137.714085983886, 6148.831721972811, 6177.1969643945995, 6180.7527698891545, 6253.937460625518, 5642.927843709682, 6148.415900489446, 6330.272018717722, 6413.518986076157, 6418.03729440569, 6037.124616930432, 6133.172021777003, 6188.81433556994, 6214.689265536615, 6225.564210505221, 6154.969225153845, 6156.476699480415, 6203.8138855834395, 6240.28236752761, 6240.313565507881, 5954.166416701752, 6088.178095957166, 6096.496448835484, 6123.63890065525, 6136.140940268277, 5074.782052307346, 5756.338021127456, 6053.4551890330085, 6055.969720151371, 6158.722857471335, 4814.927776083432, 5934.43622855828, 5956.761729530944, 6036.8188954331445, 6038.879222415615, 6071.483923866521, 6094.51243900478, 6131.938680613137, 6137.938620613915, 6143.508519318354, 5798.739056742373, 5912.940870591411, 5975.16347711312, 5978.581499295007, 5985.670788106696], "value": 5665.261849076508, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [471.2436539354336, 486.19049282943877, 509.5388673250707, 549.8460431079297, 587.8471597384679, 38123.80938095309, 40785.3882191767, 40892.97767555805, 41126.58873411265, 41195.0, 42156.57843421565, 42947.14105717884, 43001.924951876215, 43123.13753724923, 43123.70628881131, 9516.524173791317, 9606.9519652402, 9713.222942164644, 9714.757131071745, 9726.756831079208, 9671.129598336149, 9699.70900872975, 9730.270229732798, 9742.707718768448, 9772.31593788435, 9619.0, 9708.126268635822, 9718.222542196643, 9753.414795112316, 9767.51162441875, 9573.425594464354, 9682.12860842524, 9748.171405430547, 9751.122398984126, 9919.702408927744, 9630.566624501915, 9711.708648740549, 9745.171660408874, 9747.171490423323, 9748.366356186825, 40243.195136097114, 40348.0, 40608.78173654795, 40633.0, 40718.1856362874, 3149.3386388858366, 3377.4933759936207, 3435.8282085895853, 3442.2823350781096, 3571.3035957988204, 29688.40623187546, 29812.0, 30426.84786576053, 30702.232444189074, 32542.837285813657, 3143.9528407073685, 3160.873565057395, 3164.430402527544, 3192.952105718416, 3285.293661862711, 451104.7444762755, 459616.0, 461777.0, 462300.68849655875, 462306.0, 34009.8096566619, 34155.14612134716, 34194.48708269378, 34254.314913701586, 34419.31161376758, 34939.0, 35495.4675679865, 35554.0, 35710.46434303487, 36326.0, 16788.91605541989, 17067.06131162798, 17104.315827367016, 17214.913925430545, 17232.052237126827, 10859.0, 11524.711882203012, 12550.744925507377, 13174.538891138764, 13201.339933003312, 19849.908255045822, 20031.599368012558, 20033.499162520762, 20084.89957550203, 20266.290679826136, 6747.460203183734, 8070.596470176468, 8109.716159934492, 8115.3913456491, 8235.711750088718, 724.8257822327863, 959.4435227567993, 1048.8531605575226, 1060.55986765493, 1123.2193625430248, 29444.852775735984, 31101.911433099733, 31187.532187017212, 31554.0, 31700.0, 1122.074288711816, 1137.3630766770634, 1152.9220179132371, 1166.4634268236537, 1215.7143071378218, 15951.840481595267, 16195.514134575982, 16219.918900405422, 16304.184790760415, 16472.588185295463, 625940.0, 670140.0, 702184.0, 703946.0, 705489.0, 44917.77541112273, 59429.0, 60343.69828150831, 60588.0, 60665.393346066856, 1387.6184049386297, 1401.9228942408265, 1403.480712136516, 1418.581518452059, 1424.0672359604682, 30111.698883011766, 30325.0, 30332.393352132392, 30692.23269418193, 31030.68969310278, 51340.486595135066, 51907.74046129745, 51986.96026079533, 52074.47925520696, 52100.0, 578383.0, 598792.0, 600339.0, 601715.0, 602435.0, 27049.323766905985, 27260.454790903674, 27606.447871042867, 27611.30971725723, 27692.0, 48874.02251955012, 49678.751606241734, 49768.0, 49991.75004124956, 50554.0, 40423.3936490947, 40437.59562404338, 40997.97505062397, 41265.79367103145, 41842.79078604587, 34339.31321373609, 41025.384619230135, 41392.586074140076, 41822.95442613959, 42079.57920420756, 32940.50589241115, 38584.0, 39236.0, 39353.40969885397, 39607.40588891227, 28318.008869690286, 33711.4943275856, 34428.13929651779, 36148.0, 37319.067023324635, 22461.179159730546, 22490.5501889958, 24562.877185613957, 26433.074842380425, 26554.867225664522], "value": 19713.678647771085, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.8613013185121, 375.16712897367836, 382.707228969838, 389.91811719538896, 396.2629509113051, 19530.0, 22398.216062437776, 22654.43363915903, 22694.65958010629, 22780.88609556954, 20253.797462025414, 21236.04437800299, 21246.25638102663, 21288.254911078115, 22248.887555622234, 5511.751971161298, 5564.443555644443, 6215.036669316263, 6230.844228894269, 6235.407636274569, 3872.341701910682, 5809.302883653967, 6044.274687037561, 6174.876502469948, 6181.0110382338835, 6124.601900876429, 6182.258129024501, 6192.8451788705415, 6212.471939885093, 6230.345813689542, 6193.442590166884, 6225.066240063981, 6228.844278893019, 6231.813045608639, 6238.937610623903, 5738.982358828317, 5890.823275301748, 6019.608725432833, 6054.303755068179, 6064.120702498113, 13571.796423053662, 13629.863701362958, 13648.65878353049, 13689.520866769615, 13734.931325343408, 2178.575177840322, 2376.7979721723673, 2551.1836212412036, 2707.4179051503825, 2906.2443764621353, 10205.0, 10297.897021029768, 10425.113865321457, 10437.843432348522, 14291.499797507142, 1518.293993293124, 1822.4259358302224, 1827.8720489565735, 1841.4107485604611, 1911.9808801911943, 99019.50490247575, 124751.0, 133197.0, 133873.99189012172, 135474.0, 8928.553572321358, 9567.665131720356, 10070.345427547187, 10952.233343665866, 11831.408429578487, 14772.630684232765, 15009.399624014917, 15014.699706005818, 15022.023568468014, 15055.849441505445, 8606.87089693655, 8683.652653893774, 8769.0, 8774.298056155492, 8953.552322383855, 8738.519381433955, 8747.825043499222, 8762.342824288204, 8876.8668469973, 8928.241099506486, 4542.159700455426, 4599.977000114978, 4658.487566367697, 4686.5782079613, 4700.482946875841, 1773.804881463038, 1828.5112680392886, 1923.7787654419642, 1974.2004488182308, 1974.8025197480424, 794.4002278279862, 889.4929889962789, 956.4739393333639, 973.5181085362649, 998.6305067125065, 22027.889860550917, 22533.985970631362, 22666.206682766355, 22942.42643933915, 22975.425614359774, 982.3467394182932, 999.6601155606983, 1002.9247806414548, 1031.5615863258085, 1037.0355569320454, 11491.942540287246, 11881.5841445549, 12030.699232519257, 12041.939790301167, 12072.698182545506, 498511.07444627624, 610930.0, 618698.0, 619072.0, 638393.0, 134096.3295183518, 136788.31605842107, 137501.0, 139669.3016534931, 139783.30108349392, 960.188640598693, 1023.2019025160387, 1030.8093002794508, 1035.1460045462522, 1040.5265604150093, 17540.649187015933, 19809.0, 20841.37475875726, 20883.37349879506, 21055.263065792624, 40607.796961015, 46805.76597116992, 51931.74034129805, 60650.180494585235, 61727.69136154291, 89343.10656893348, 89778.65332020156, 90463.0, 91100.0, 91191.0, 8390.24487796077, 8463.57682115904, 8528.616212270339, 8748.650053998024, 8857.247133993682, 13264.86735132675, 13815.723685526435, 14000.36998335057, 14010.299485025504, 14185.148891066568, 11928.642140735792, 11951.462184201906, 12054.819177712518, 12069.75860482803, 12080.939595301967, 11732.413379330828, 11754.823677644672, 11840.70398240051, 11888.76222475563, 11914.642560723192, 12066.698332541757, 12083.154179207371, 12096.334701591144, 12137.271763693854, 12154.75690486203, 8398.244158025807, 8447.408681392244, 8565.528895910784, 8593.269572086443, 8680.0, 11577.363245021268, 11922.225055371373, 11998.700032499257, 12059.69850753703, 12123.75752484963], "value": 9819.27773702177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.8414515951758, 1450.883929285657, 1679.8152203257632, 1719.1404297851075, 1884.5288677830542, 7859.685612575505, 8381.748547543568, 8532.616032278547, 8877.112288771119, 8900.732978010661, 7329.486935914488, 8540.402171847973, 8661.177188167114, 8731.825363492726, 8744.0, 2134.114342547841, 2152.5587254612847, 2163.0, 2164.145162660756, 2164.545445456456, 2041.9795802042013, 2315.8842057897036, 2338.1816364272454, 2365.042157926034, 2378.4291769975166, 2323.2217207235512, 2329.3477826208687, 2348.518553696488, 2367.502824406868, 2380.809535237177, 1956.178405069874, 2298.6207275799475, 2304.8847557622053, 2309.191782875997, 2311.133325003124, 2314.2247347138727, 2316.8841557922037, 2326.8487548309304, 2329.7903188712926, 2347.448349637834, 8802.603882825224, 8915.197632213067, 8915.687950921687, 8923.955380223057, 8932.464052156827, 5175.120229560984, 5261.76322065508, 5324.361076670824, 5324.494173053554, 5344.43883392246, 3422.4866270059692, 3538.115471132217, 3595.3281723998466, 3606.9098272543133, 3628.600853906068, 920.7018104472661, 1041.9166466682648, 1069.7593041565585, 1074.752806854428, 1089.4280502736049, 11221.551137954471, 11352.943235283854, 11360.715982100513, 11362.431878406129, 11416.687080985794, 4134.875953721393, 4542.409486766699, 4556.11155824611, 4749.596284315872, 4757.595604373598, 9692.70921872345, 9725.805483890425, 9727.221822254203, 9737.367071140354, 9763.804723905481, 5265.104932161542, 5325.920111198335, 5342.91985620216, 5350.9732451337495, 5356.7321633918145, 4400.361947517656, 4679.9298010529865, 4812.711237325771, 4897.142999975062, 4901.485344038896, 3959.7822119783687, 3966.603339666068, 4001.419794129893, 4033.616806403387, 4105.055837157471, 1266.645339304996, 1302.2772361339548, 1303.0162227518163, 1317.4532568983764, 1330.2085259270718, 857.4374021133666, 928.5310917986374, 931.2503434734967, 937.2689302344182, 944.6268723854039, 5780.710964451845, 5869.442402971797, 5938.736509108677, 5957.285125784933, 6052.12244224585, 424.2279052125164, 428.1714881703913, 432.9523752387235, 435.81477871904946, 453.22724754293847, 3433.5193072969805, 3944.8027598619956, 4027.1744292419985, 4091.8567850125696, 4108.856190033334, 10044.598216071276, 10058.396496210251, 10280.434576098387, 10394.324368915995, 10420.739481513023, 9099.681511147079, 10204.0, 10384.273100883016, 10390.376577405379, 10416.843747343795, 7912.920870791334, 7919.366450683931, 7987.1613480584865, 8034.678612855537, 8112.067112282163, 5806.647095931313, 5868.530517558671, 5883.441073098049, 5910.556708246812, 5959.255093113361, 9484.288678349289, 9739.659111931049, 9754.414735115915, 9756.658516951873, 9758.316917815968, 9697.757556061155, 9860.457674827954, 9882.160016398686, 9910.752231194278, 9947.950260248652, 6239.376062393724, 7387.1135463744695, 7406.481546291708, 7480.738174163878, 7503.1746507883, 7965.163657815846, 8034.076081250497, 8058.959705201437, 8105.189481051848, 8119.715809946623, 7247.057882475245, 7322.816929576803, 7378.151512575908, 7491.250874912683, 7502.737404190827, 7187.9640601796655, 7267.963660181666, 7280.907863820257, 7349.963250183929, 7371.668274927534, 5781.82654520365, 5840.269966254218, 5961.493273071837, 6644.704282664834, 6881.10545629085, 4920.630952678635, 4943.209086546135, 4984.675996060245, 4986.750662466935, 5059.139946209227, 4993.525615066563, 5059.418166910852, 5122.078025955364, 5148.665336753099, 5212.400573934046], "value": 4421.141924287538, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.4597880112581, 301.4769375134142, 315.4904828701647, 318.10136364769534, 320.2538086259017, 5667.0, 5677.460641239086, 5743.052396354597, 5867.765289388425, 5881.411858814122, 5731.598788084836, 5772.989726797815, 5780.219670344502, 5786.074228123501, 5798.565107616935, 3593.9820300898523, 4351.434313539251, 4358.673099517533, 4389.4513185851765, 4394.912101757963, 3787.080371815172, 3807.2195199983935, 4341.327094300388, 4393.406890069848, 4428.645708343341, 3528.9470657940024, 3771.641694039062, 4274.658027357819, 4313.805878735465, 4346.695731298811, 3601.405768048269, 3621.674049335546, 4307.332363483665, 4323.762193079379, 4345.847895323648, 3413.8805141819917, 3734.9813250933844, 3743.3262012837677, 3749.4000959846294, 3766.1753684736445, 4392.9676526016365, 5228.2680424740565, 5646.407127251661, 5648.491635752802, 5724.341700704431, 4849.345338379344, 4929.334539837112, 4937.308776771255, 4958.925616115761, 4978.103941290567, 5285.524302812765, 5612.438756124396, 5941.316748573883, 5977.820665380045, 6158.599691020069, 3979.641832235113, 4016.136530645925, 4040.1919616076902, 4041.7979101045125, 4059.3302105152616, 6366.968165159191, 6378.744850205986, 6423.903641445382, 6431.0031945048595, 6453.419192272718, 3992.441058251847, 4098.221337945781, 4104.015036391244, 4104.4664193654635, 4121.9381709274385, 4138.91722165555, 4152.480939882515, 4154.356074808409, 4177.26897792885, 4200.810963506588, 4345.956540434619, 4703.623710103184, 4949.678270912451, 4966.553010229024, 4977.925331120036, 4750.857474275777, 5020.941414020234, 5069.594432445396, 5416.322959630046, 6063.181470501426, 1453.324204245031, 1477.3130494319978, 1486.0637798187072, 1493.939303094793, 1494.140869000329, 721.0266140709999, 906.6962567539816, 914.7255823252998, 919.8068405634891, 931.8322701913585, 4238.851640192578, 4592.563706447882, 4760.309755085494, 4783.856484305476, 4798.832040878622, 4842.806287748451, 4848.5636292733825, 4954.504549545017, 5291.894162116736, 5399.649022813504, 4317.222899877989, 4418.712783669115, 4437.889052773707, 4645.814167433333, 4864.489228631013, 2319.814414846808, 2360.811135109187, 2438.3416477550963, 2814.5356016257088, 2825.615448430254, 4685.718856868599, 5385.919211211835, 5480.780768769284, 5541.944580554143, 5564.304461942257, 4927.802887884516, 5435.374931882805, 5452.591055670761, 5472.945270547243, 5502.202180683778, 5402.837914862561, 5508.338999320107, 5526.364468086222, 5560.77756889728, 5597.997431836094, 4633.953660463352, 4669.136209801198, 5347.385050719217, 5366.275552800478, 5411.918821217763, 5272.947270527399, 5300.761465733974, 5607.775688972395, 5851.414858514115, 5994.920914235305, 5682.801101961411, 5978.461938425563, 6547.476201903741, 6612.603243805387, 6632.369924857131, 4085.895763681766, 4087.5708050654252, 4087.5912408758886, 4113.876583702494, 4121.4848143982, 5194.610404219623, 5361.35663720356, 6064.514838812973, 6221.813345599639, 6261.090367437975, 5098.5411312982005, 5313.299744081856, 6025.8192254232445, 6047.9395206047375, 6082.840591589922, 6054.455099041107, 6093.329733729198, 6137.0, 6137.956547386866, 6177.96911015442, 5439.972800135974, 5466.326291021279, 5652.523697925664, 5913.201717768046, 5997.970010149921, 6013.819585412444, 6086.72609732572, 6130.877382452415, 6131.662758548323, 6158.753649853956, 4610.386364772303, 5407.270018547446, 5479.287692599936, 5849.210356601804, 5906.40935906406], "value": 4206.037745303585, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.3201949777254, 706.6643344411403, 770.4260326057084, 790.2097902097902, 820.9220124088209, 15087.245637718112, 15285.235738213101, 15766.60583485412, 15789.131597762118, 15817.209139543005, 14467.927660361684, 14482.131072135653, 14551.636209094751, 14596.562103136896, 14608.634784130401, 720.5424555407302, 892.2282225874604, 892.5849479991803, 906.4923642760042, 911.1162172692477, 877.0440220160025, 879.3712495565669, 888.6489836514573, 919.880415545978, 924.1359329027347, 947.8957314695378, 982.346739418286, 982.4301904895144, 985.6106837799065, 986.9013098690109, 960.6829746183778, 976.3604838830541, 976.8827740671094, 979.4661909259471, 980.8577756225308, 684.7603338831419, 686.4885660183146, 720.9279072092748, 721.5346101764385, 721.95307305025, 15302.081875087419, 15486.380544778196, 15509.767353489706, 15548.689026219525, 15555.144467054308, 14970.925145374204, 15029.098254104789, 15035.624109397244, 15129.243537823066, 15250.847491525054, 11010.449477526092, 11086.833697494543, 11225.887741122566, 11352.886471135265, 11427.371494567795, 3983.083890705154, 4033.9394909076386, 4080.551139374696, 4087.713860029799, 4093.713440059197, 122744.0, 124633.13050304343, 125345.74654253523, 125831.0, 126426.0, 11607.825882611767, 11650.30098194111, 11655.242409243541, 11830.408479575986, 11871.465784039567, 19796.604067918848, 22928.656070158962, 23000.769992300196, 24218.87890560571, 24309.027638894248, 7667.616619169019, 7928.5909644695985, 8095.23095305945, 8301.46040507365, 8454.450460720034, 4491.977540112279, 4532.297493888453, 4545.931811022837, 4616.930746038812, 4630.097131059411, 3510.2452972611013, 3539.150603855108, 3544.8227588620466, 3586.6951309138494, 3643.708503319781, 680.6664734280167, 682.6382017530717, 683.2893790457967, 685.3934268172603, 690.9101816763789, 496.7541067171773, 607.6293460988793, 610.9816705498843, 616.2358675242667, 649.422014407178, 8752.47485150893, 8854.822903541894, 8889.0, 9133.49765762876, 9283.39657922233, 540.7999040355094, 610.6275172144988, 622.17561730707, 686.114911763829, 700.4606453031138, 3546.432570788713, 4371.868843934687, 4557.384753058361, 4617.353570500132, 4690.7654617269, 148770.25614871856, 153116.0, 153274.0, 154459.0, 156446.0, 82547.0, 93960.53019734858, 114415.0, 122132.38933805274, 123457.0, 84788.0, 99091.00908990818, 105047.0, 106420.46789766001, 110816.0, 9453.480058596842, 9583.808323833624, 9672.177864881283, 9782.657606983721, 9876.851847222153, 57524.84950301054, 61062.38937610567, 61459.0, 62662.0, 62922.37077629165, 79807.0, 82782.0, 89069.55465222632, 89941.0, 90772.54613727154, 12824.615261542169, 13294.734105318033, 13476.460941562227, 13575.049746517649, 14077.94415418868, 14374.065685730395, 14388.35252413623, 14652.560423187322, 14898.627534311729, 14969.401223951356, 13136.5549789525, 13432.19406835593, 13528.59414217575, 13564.93217533906, 13671.0, 13199.802002970155, 13300.135491193041, 13387.598372048855, 13435.19388836673, 13442.596722098353, 12885.871141288468, 12919.612411627666, 13118.900975843819, 13236.404361803548, 13297.401616927067, 11165.05097066726, 11235.943820280847, 11489.942550287195, 11744.58893938708, 11840.0, 10763.461826908466, 11343.20597558163, 11454.112038140776, 11532.481038353462, 11648.359340236368], "value": 7908.216881374968, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 127.0, 167.0, 173.0, 115.0, 114.0, 121.0, 171.0, 112.0], "value": 134.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 133.0, 150.0, 96.0, 118.0, 150.0, 143.0, 197.0, 109.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 201.0, 213.0, 216.0, 196.0, 200.0, 197.0, 195.0, 201.0, 197.0], "value": 201.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 82.0, 75.0, 144.0, 85.0, 69.0, 59.0, 61.0, 134.0, 76.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 118.0, 70.0, 72.0, 101.0, 112.0, 70.0, 71.0, 114.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 88.0, 90.0, 87.0, 90.0, 88.0, 91.0, 89.0, 91.0, 88.0], "value": 93.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 96.0, 97.0, 99.0, 96.0, 108.0, 97.0, 155.0, 99.0, 102.0], "value": 105.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 100.0, 149.0, 147.0, 101.0, 151.0, 125.0, 92.0, 113.0], "value": 116.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 56.0, 57.0, 59.0, 55.0, 58.0, 58.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 77.0, 81.0, 81.0, 77.0, 75.0, 72.0, 72.0, 71.0], "value": 74.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 83.0, 85.0, 85.0, 84.0, 85.0, 82.0, 89.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 156.0, 153.0, 159.0, 156.0, 125.0, 156.0, 150.0, 245.0, 140.0], "value": 158.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 163.0, 167.0, 166.0, 172.0, 163.0, 169.0, 163.0, 166.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 62.0, 61.0, 72.0, 86.0, 85.0, 89.0, 91.0, 90.0], "value": 78.4, "unit": "score"}]}]} 17:11:31 INFO - Return code: 0 17:11:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:11:31 ERROR - # TBPL SUCCESS # 17:11:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:11:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:11:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:11:31 INFO - 2016-07-04 17:11:31.334 screenresolution[1675:10475] starting screenresolution argv=screenresolution get 17:11:31 INFO - 2016-07-04 17:11:31.337 screenresolution[1675:10475] Display 0: 1600x1200x32@60 17:11:31 INFO - 2016-07-04 17:11:31.343 screenresolution[1676:10478] starting screenresolution argv=screenresolution list 17:11:31 INFO - Available Modes on Display 0 17:11:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:11:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:11:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:11:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:11:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:11:31 INFO - Intel Iris: 17:11:31 INFO - Chipset Model: Intel Iris 17:11:31 INFO - Type: GPU 17:11:31 INFO - Bus: Built-In 17:11:31 INFO - VRAM (Dynamic, Max): 1536 MB 17:11:31 INFO - Vendor: Intel (0x8086) 17:11:31 INFO - Device ID: 0x0a2e 17:11:31 INFO - Revision ID: 0x0009 17:11:31 INFO - Displays: 17:11:31 INFO - Display: 17:11:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:11:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:11:31 INFO - Display Serial Number: 1600x1200 60 17:11:31 INFO - Main Display: Yes 17:11:31 INFO - Mirror: Off 17:11:31 INFO - Online: Yes 17:11:31 INFO - Rotation: Supported 17:11:31 INFO - Return code: 0 17:11:31 INFO - Running post-action listener: _resource_record_post_action 17:11:31 INFO - ##### 17:11:31 INFO - ##### Finished run-tests step (success) 17:11:31 INFO - ##### 17:11:31 INFO - Running post-run listener: _resource_record_post_run 17:11:31 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 32759296; Write bytes: 709456384; Read time: 315; Write time: 2010 17:11:31 INFO - TinderboxPrint: CPU usage
54.4% 17:11:31 INFO - TinderboxPrint: I/O read bytes / time
32,759,296 / 315 17:11:31 INFO - TinderboxPrint: I/O write bytes / time
709,456,384 / 2,010 17:11:31 INFO - TinderboxPrint: CPU idle
2,207.8 (45.6%) 17:11:31 INFO - TinderboxPrint: CPU system
974.9 (20.2%) 17:11:31 INFO - TinderboxPrint: CPU user
1,654.9 (34.2%) 17:11:31 INFO - TinderboxPrint: Swap in / out
435,855,360 / 0 17:11:31 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 408121856; Write bytes: 410023936; Read time: 30947; Write time: 813 17:11:31 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 29212160; Write bytes: 297875968; Read time: 284; Write time: 1192 17:11:32 INFO - Running post-run listener: _upload_blobber_files 17:11:32 INFO - Blob upload gear active. 17:11:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:11:32 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:11:32 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:11:32 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:11:32 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:11:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:11:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:33 INFO - (blobuploader) - INFO - Done attempting. 17:11:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:11:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:34 INFO - (blobuploader) - INFO - Done attempting. 17:11:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:11:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:11:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:36 INFO - (blobuploader) - INFO - Done attempting. 17:11:36 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:36 INFO - Return code: 0 17:11:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:11:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9972cdf49cb8e86933e596b1e17fd47d7f6d036f04a39031d269cdbc0868e47ae878b5d3278848629b80fa6031f94ec5a37d3d1be160ae51d9d7bb2ab97fca30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ce50c0335dd8d18094bc4086aa629207dc8a1b6a1c9438afc528b7d621266f31f7f69a6992db17f12e9a1057385f09298235c7dea8dda4b16b89ae51caec04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe02228a73c0aa82a2bb8a89a4966238a375153c617aa4a06b0326be253d98bdac1388df2c37a9b4b106be182c4a67edb18ada46c727e1ad0f7845d5e018d4cc"} 17:11:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:11:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:11:36 INFO - Contents: 17:11:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9972cdf49cb8e86933e596b1e17fd47d7f6d036f04a39031d269cdbc0868e47ae878b5d3278848629b80fa6031f94ec5a37d3d1be160ae51d9d7bb2ab97fca30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ce50c0335dd8d18094bc4086aa629207dc8a1b6a1c9438afc528b7d621266f31f7f69a6992db17f12e9a1057385f09298235c7dea8dda4b16b89ae51caec04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe02228a73c0aa82a2bb8a89a4966238a375153c617aa4a06b0326be253d98bdac1388df2c37a9b4b106be182c4a67edb18ada46c727e1ad0f7845d5e018d4cc"} 17:11:36 INFO - Running post-run listener: copy_logs_to_upload_dir 17:11:36 INFO - Copying logs to upload dir... 17:11:36 INFO - mkdir: /builds/slave/test/build/upload/logs 17:11:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1340.057890 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 20 secs) (at 2016-07-04 17:11:36.703773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:36.709153) ========= 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.XXSp8Mf6SL/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.434QWmdkG4/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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/Firefox/sha512/9972cdf49cb8e86933e596b1e17fd47d7f6d036f04a39031d269cdbc0868e47ae878b5d3278848629b80fa6031f94ec5a37d3d1be160ae51d9d7bb2ab97fca30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ce50c0335dd8d18094bc4086aa629207dc8a1b6a1c9438afc528b7d621266f31f7f69a6992db17f12e9a1057385f09298235c7dea8dda4b16b89ae51caec04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe02228a73c0aa82a2bb8a89a4966238a375153c617aa4a06b0326be253d98bdac1388df2c37a9b4b106be182c4a67edb18ada46c727e1ad0f7845d5e018d4cc"} build_url:https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/ZW4n2dRRRBm53rczXapIeA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9972cdf49cb8e86933e596b1e17fd47d7f6d036f04a39031d269cdbc0868e47ae878b5d3278848629b80fa6031f94ec5a37d3d1be160ae51d9d7bb2ab97fca30", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0ce50c0335dd8d18094bc4086aa629207dc8a1b6a1c9438afc528b7d621266f31f7f69a6992db17f12e9a1057385f09298235c7dea8dda4b16b89ae51caec04", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe02228a73c0aa82a2bb8a89a4966238a375153c617aa4a06b0326be253d98bdac1388df2c37a9b4b106be182c4a67edb18ada46c727e1ad0f7845d5e018d4cc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:36.742236) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:36.742564) ========= 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.XXSp8Mf6SL/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.434QWmdkG4/Listeners TMPDIR=/var/folders/wd/lr9qrw8n6cn5lsbcg99yj9x400000w/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.005254 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 17:11:36.791591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 17:11:36.791947) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 17:11:36.792287) ========= ========= Total master_lag: 0.54 =========