builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0118 starttime: 1467808568.77 results: success (0) buildid: 20160706030233 builduid: 1ca1588cffd34b0e9bc5005b5c98b846 revision: 95ffbc4ff63584631c408e8d9912961fcf68bb09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.770481) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.770873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.771139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.867701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.867967) ========= 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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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-06 05:36:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-07-06 05:36:08 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104381 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.995742) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:08.996048) ========= 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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.020413 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:09.251353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 05:36:09.252566) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 95ffbc4ff63584631c408e8d9912961fcf68bb09 --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 95ffbc4ff63584631c408e8d9912961fcf68bb09 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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-06 05:36:09,656 truncating revision to first 12 chars 2016-07-06 05:36:09,656 Setting DEBUG logging. 2016-07-06 05:36:09,656 attempt 1/10 2016-07-06 05:36:09,656 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/95ffbc4ff635?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 05:36:10,742 unpacking tar archive at: mozilla-central-95ffbc4ff635/testing/mozharness/ program finished with exit code 0 elapsedTime=1.335849 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 05:36:10.943167) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:10.943468) ========= script_repo_revision: 95ffbc4ff63584631c408e8d9912961fcf68bb09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:10.943875) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:10.944141) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 05:36:10.962395) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-07-06 05:36:10.962685) ========= /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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:36:11 INFO - MultiFileLogger online at 20160706 05:36:11 in /builds/slave/test 05:36:11 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 05:36:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:36:11 INFO - {'append_to_log': False, 05:36:11 INFO - 'base_work_dir': '/builds/slave/test', 05:36:11 INFO - 'blob_upload_branch': 'Firefox', 05:36:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:36:11 INFO - 'branch': 'Firefox', 05:36:11 INFO - 'buildbot_json_path': 'buildprops.json', 05:36:11 INFO - 'config_files': ('talos/mac_config.py',), 05:36:11 INFO - 'default_actions': ('clobber', 05:36:11 INFO - 'read-buildbot-config', 05:36:11 INFO - 'download-and-extract', 05:36:11 INFO - 'populate-webroot', 05:36:11 INFO - 'create-virtualenv', 05:36:11 INFO - 'install', 05:36:11 INFO - 'run-tests'), 05:36:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:36:11 INFO - 'download_minidump_stackwalk': True, 05:36:11 INFO - 'download_symbols': 'ondemand', 05:36:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:36:11 INFO - 'tooltool.py': '/tools/tooltool.py', 05:36:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:36:11 INFO - '/tools/misc-python/virtualenv.py')}, 05:36:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:36:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:36:11 INFO - 'installer_path': 'installer.exe', 05:36:11 INFO - 'log_level': 'info', 05:36:11 INFO - 'log_name': 'talos', 05:36:11 INFO - 'log_to_console': True, 05:36:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:36:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:36:11 INFO - 'opt_config_files': (), 05:36:11 INFO - 'pip_index': False, 05:36:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:11 INFO - 'cmd': ('bash', 05:36:11 INFO - '-c', 05:36:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:11 INFO - 'enabled': True, 05:36:11 INFO - 'halt_on_failure': False, 05:36:11 INFO - 'name': 'check_screen_resolution'},), 05:36:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:36:11 INFO - 'cmd': ('bash', 05:36:11 INFO - '-c', 05:36:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:36:11 INFO - 'enabled': True, 05:36:11 INFO - 'halt_on_failure': False, 05:36:11 INFO - 'name': 'check_screen_resolution'},), 05:36:11 INFO - 'run_cmd_checks_enabled': True, 05:36:11 INFO - 'sps_profile': False, 05:36:11 INFO - 'sps_profile_interval': 0, 05:36:11 INFO - 'suite': 'dromaeojs-e10s', 05:36:11 INFO - 'system_bits': '32', 05:36:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:36:11 INFO - 'title': 't-yosemite-r7-0118', 05:36:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:36:11 INFO - 'use_talos_json': True, 05:36:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:36:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:36:11 INFO - 'work_dir': 'build'} 05:36:11 INFO - ##### 05:36:11 INFO - ##### Running clobber step. 05:36:11 INFO - ##### 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: clobber 05:36:11 INFO - rmtree: /builds/slave/test/build 05:36:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:36:11 INFO - Running post-action listener: _resource_record_post_action 05:36:11 INFO - ##### 05:36:11 INFO - ##### Finished clobber step (success) 05:36:11 INFO - ##### 05:36:11 INFO - ##### 05:36:11 INFO - ##### Running read-buildbot-config step. 05:36:11 INFO - ##### 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: read_buildbot_config 05:36:11 INFO - Using buildbot properties: 05:36:11 INFO - { 05:36:11 INFO - "project": "", 05:36:11 INFO - "product": "firefox", 05:36:11 INFO - "script_repo_revision": "production", 05:36:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:36:11 INFO - "repository": "", 05:36:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:36:11 INFO - "buildid": "20160706030233", 05:36:11 INFO - "stage_platform": "macosx64", 05:36:11 INFO - "basedir": "/builds/slave/test", 05:36:11 INFO - "nightly_build": "True", 05:36:11 INFO - "buildnumber": 43, 05:36:11 INFO - "slavename": "t-yosemite-r7-0118", 05:36:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:36:11 INFO - "platform": "yosemite_r7", 05:36:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:36:11 INFO - "branch": "mozilla-central", 05:36:11 INFO - "repo_path": "mozilla-central", 05:36:11 INFO - "revision": "95ffbc4ff63584631c408e8d9912961fcf68bb09", 05:36:11 INFO - "pgo_build": "False", 05:36:11 INFO - "builduid": "1ca1588cffd34b0e9bc5005b5c98b846", 05:36:11 INFO - "slavebuilddir": "test" 05:36:11 INFO - } 05:36:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 05:36:11 INFO - Running post-action listener: _resource_record_post_action 05:36:11 INFO - ##### 05:36:11 INFO - ##### Finished read-buildbot-config step (success) 05:36:11 INFO - ##### 05:36:11 INFO - ##### 05:36:11 INFO - ##### Running download-and-extract step. 05:36:11 INFO - ##### 05:36:11 INFO - Running pre-action listener: _resource_record_pre_action 05:36:11 INFO - Running main action method: download_and_extract 05:36:11 INFO - mkdir: /builds/slave/test/build/tests 05:36: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')]} 05:36:11 INFO - https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:36:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:36:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 05:36:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:30 INFO - Downloaded 1199 bytes. 05:36:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 05:36:30 INFO - Using the following test package requirements: 05:36:30 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:36:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 05:36:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 05:36:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'jsshell-mac.zip'], 05:36:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 05:36:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 05:36:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 05:36:30 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 05:36:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 05:36:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 05:36:30 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 05:36:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:30 INFO - https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:36:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:36:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:36:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:31 INFO - Downloaded 18804321 bytes. 05:36:31 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'] 05:36:31 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 05:36:34 INFO - Return code: 0 05:36:34 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 05:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:34 INFO - https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:36:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:36:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 05:36:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:39 INFO - Downloaded 18804321 bytes. 05:36:39 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'] 05:36:39 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 05:36:43 INFO - Return code: 0 05:36:43 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')]} 05:36:43 INFO - https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:36:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:36:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 05:36:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:44 INFO - Downloaded 14403333 bytes. 05:36:44 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'] 05:36:44 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 05:36:44 INFO - Return code: 0 05:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:36:44 INFO - https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 05:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MDlKT1VESPubPRYuiHyTGA/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 05:36:48 INFO - Downloaded 112605836 bytes. 05:36:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:36:48 INFO - mkdir: /builds/slave/test/properties 05:36:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:36:48 INFO - Writing to file /builds/slave/test/properties/build_url 05:36:48 INFO - Contents: 05:36:48 INFO - build_url:https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 05:36:49 INFO - Running post-action listener: _resource_record_post_action 05:36:49 INFO - Running post-action listener: set_extra_try_arguments 05:36:49 INFO - ##### 05:36:49 INFO - ##### Finished download-and-extract step (success) 05:36:49 INFO - ##### 05:36:49 INFO - ##### 05:36:49 INFO - ##### Running populate-webroot step. 05:36:49 INFO - ##### 05:36:49 INFO - Running pre-action listener: _resource_record_pre_action 05:36:49 INFO - Running main action method: populate_webroot 05:36:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:36:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:36:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:36:49 INFO - '--tppagecycles', 05:36:49 INFO - '7'], 05:36:49 INFO - 'tests': ['tsvgm']}}, 05:36:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:36:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:36:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:36:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:36:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:36:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['damp', 'tps']}, 05:36:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'tests': ['damp', 'tps']}, 05:36:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['dromaeo_dom']}, 05:36:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:36:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['basic_compositor_video']}, 05:36:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:36:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['a11yr', 05:36:49 INFO - 'ts_paint', 05:36:49 INFO - 'tpaint', 05:36:49 INFO - 'sessionrestore', 05:36:49 INFO - 'sessionrestore_no_auto_restore', 05:36:49 INFO - 'tabpaint']}, 05:36:49 INFO - 'other-e10s': {'tests': ['a11yr', 05:36:49 INFO - 'ts_paint', 05:36:49 INFO - 'tpaint', 05:36:49 INFO - 'sessionrestore', 05:36:49 INFO - 'sessionrestore_no_auto_restore', 05:36:49 INFO - 'tabpaint']}, 05:36:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:36:49 INFO - 'ts_paint', 05:36:49 INFO - 'tpaint', 05:36:49 INFO - 'sessionrestore', 05:36:49 INFO - 'sessionrestore_no_auto_restore', 05:36:49 INFO - 'tabpaint']}, 05:36:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:36:49 INFO - 'ts_paint', 05:36:49 INFO - 'tpaint', 05:36:49 INFO - 'sessionrestore', 05:36:49 INFO - 'sessionrestore_no_auto_restore', 05:36:49 INFO - 'tabpaint']}, 05:36:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['a11yr', 05:36:49 INFO - 'ts_paint', 05:36:49 INFO - 'tpaint', 05:36:49 INFO - 'sessionrestore', 05:36:49 INFO - 'sessionrestore_no_auto_restore', 05:36:49 INFO - 'tabpaint']}, 05:36:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['a11yr', 05:36:49 INFO - 'ts_paint', 05:36:49 INFO - 'tpaint', 05:36:49 INFO - 'sessionrestore', 05:36:49 INFO - 'sessionrestore_no_auto_restore', 05:36:49 INFO - 'tabpaint']}, 05:36:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['tsvgx', 05:36:49 INFO - 'tsvgr_opacity', 05:36:49 INFO - 'tart', 05:36:49 INFO - 'tscrollx', 05:36:49 INFO - 'cart']}, 05:36:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:36:49 INFO - 'tsvgr_opacity', 05:36:49 INFO - 'tart', 05:36:49 INFO - 'tscrollx', 05:36:49 INFO - 'cart']}, 05:36:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'talos_options': ['--disable-e10s'], 05:36:49 INFO - 'tests': ['tp5o']}, 05:36:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'tests': ['tp5o']}, 05:36:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'talos_options': ['--disable-e10s', 05:36:49 INFO - '--xperf_path', 05:36:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:49 INFO - 'tests': ['tp5n']}, 05:36:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:36:49 INFO - 'talos_options': ['--xperf_path', 05:36:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:36:49 INFO - 'tests': ['tp5n']}}, 05:36:49 INFO - 'talos.zip': {'path': '', 05:36:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:36:49 INFO - Running post-action listener: _resource_record_post_action 05:36:49 INFO - ##### 05:36:49 INFO - ##### Finished populate-webroot step (success) 05:36:49 INFO - ##### 05:36:49 INFO - ##### 05:36:49 INFO - ##### Running create-virtualenv step. 05:36:49 INFO - ##### 05:36:49 INFO - Running pre-action listener: _resource_record_pre_action 05:36:49 INFO - Running main action method: create_virtualenv 05:36:49 INFO - Creating virtualenv /builds/slave/test/build/venv 05:36:49 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 05:36:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:36:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:36:49 INFO - Using real prefix '/tools/python27' 05:36:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:36:50 INFO - Installing distribute.............................................................................................................................................................................................done. 05:36:53 INFO - Installing pip.................done. 05:36:53 INFO - Return code: 0 05:36:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:36:53 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')]} 05:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 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')]} 05:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:36:53 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 05:36:53 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 05:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:53 INFO - 'HOME': '/Users/cltbld', 05:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:53 INFO - 'LOGNAME': 'cltbld', 05:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:53 INFO - 'MOZ_NO_REMOTE': '1', 05:36:53 INFO - 'NO_EM_RESTART': '1', 05:36:53 INFO - 'PAGER': '/bin/cat', 05:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:53 INFO - 'PWD': '/builds/slave/test', 05:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:53 INFO - 'SHELL': '/bin/bash', 05:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:36:53 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:53 INFO - 'USER': 'cltbld', 05:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:53 INFO - 'XPC_FLAGS': '0x0', 05:36:53 INFO - 'XPC_SERVICE_NAME': '0', 05:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:53 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 05:36:53 INFO - Cleaning up... 05:36:53 INFO - Return code: 0 05:36:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:36:53 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')]} 05:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 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')]} 05:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:53 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:36:53 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 05:36:53 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 05:36:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:36:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:53 INFO - 'HOME': '/Users/cltbld', 05:36:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:53 INFO - 'LOGNAME': 'cltbld', 05:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:53 INFO - 'MOZ_NO_REMOTE': '1', 05:36:53 INFO - 'NO_EM_RESTART': '1', 05:36:53 INFO - 'PAGER': '/bin/cat', 05:36:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:53 INFO - 'PWD': '/builds/slave/test', 05:36:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:53 INFO - 'SHELL': '/bin/bash', 05:36:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:36:53 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:36:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:53 INFO - 'USER': 'cltbld', 05:36:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:53 INFO - 'XPC_FLAGS': '0x0', 05:36:53 INFO - 'XPC_SERVICE_NAME': '0', 05:36:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:53 INFO - Downloading/unpacking psutil>=3.1.1 05:36:53 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 05:36:53 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 05:36:53 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 05:36:53 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 05:36:53 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 05:36:53 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 05:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:57 INFO - Installing collected packages: psutil 05:36:57 INFO - Running setup.py install for psutil 05:36:57 INFO - building 'psutil._psutil_osx' extension 05:36:57 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 05:36:57 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 05:36:57 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 05:36:57 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 05:36:57 INFO - building 'psutil._psutil_posix' extension 05:36:57 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 05:36:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:36:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:36:57 INFO - ^ 05:36:57 INFO - 1 warning generated. 05:36:57 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 05:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:36:58 INFO - Successfully installed psutil 05:36:58 INFO - Cleaning up... 05:36:58 INFO - Return code: 0 05:36:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:36:58 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')]} 05:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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')]} 05:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:36:58 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:36:58 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 05:36:58 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 05:36:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:36:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:36:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:36:58 INFO - 'HOME': '/Users/cltbld', 05:36:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:36:58 INFO - 'LOGNAME': 'cltbld', 05:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:36:58 INFO - 'MOZ_NO_REMOTE': '1', 05:36:58 INFO - 'NO_EM_RESTART': '1', 05:36:58 INFO - 'PAGER': '/bin/cat', 05:36:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:36:58 INFO - 'PWD': '/builds/slave/test', 05:36:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:36:58 INFO - 'SHELL': '/bin/bash', 05:36:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:36:58 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:36:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:36:58 INFO - 'USER': 'cltbld', 05:36:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:36:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:36:58 INFO - 'XPC_FLAGS': '0x0', 05:36:58 INFO - 'XPC_SERVICE_NAME': '0', 05:36:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:36:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:36:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:36:58 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 05:37:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:37:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:37:00 INFO - Installing collected packages: mozsystemmonitor 05:37:00 INFO - Running setup.py install for mozsystemmonitor 05:37:01 INFO - Successfully installed mozsystemmonitor 05:37:01 INFO - Cleaning up... 05:37:01 INFO - Return code: 0 05:37:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:01 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:37:01 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 05:37:01 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 05:37:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:01 INFO - 'HOME': '/Users/cltbld', 05:37:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:01 INFO - 'LOGNAME': 'cltbld', 05:37:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:01 INFO - 'MOZ_NO_REMOTE': '1', 05:37:01 INFO - 'NO_EM_RESTART': '1', 05:37:01 INFO - 'PAGER': '/bin/cat', 05:37:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:01 INFO - 'PWD': '/builds/slave/test', 05:37:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:01 INFO - 'SHELL': '/bin/bash', 05:37:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:01 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:01 INFO - 'USER': 'cltbld', 05:37:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:01 INFO - 'XPC_FLAGS': '0x0', 05:37:01 INFO - 'XPC_SERVICE_NAME': '0', 05:37:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:01 INFO - Downloading/unpacking jsonschema==2.5.1 05:37:01 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 05:37:01 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 05:37:01 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 05:37:01 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 05:37:01 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 05:37:01 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 05:37:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:37:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:37:04 INFO - warning: no files found matching '*.txt' 05:37:04 INFO - no previously-included directories found matching 'build' 05:37:04 INFO - no previously-included directories found matching 'dist' 05:37:04 INFO - no previously-included directories found matching '.git*' 05:37:04 INFO - Installing collected packages: jsonschema, functools32 05:37:04 INFO - Running setup.py install for functools32 05:37:04 INFO - warning: no files found matching '*.txt' 05:37:04 INFO - no previously-included directories found matching 'build' 05:37:04 INFO - no previously-included directories found matching 'dist' 05:37:04 INFO - no previously-included directories found matching '.git*' 05:37:04 INFO - Successfully installed jsonschema functools32 05:37:04 INFO - Cleaning up... 05:37:04 INFO - Return code: 0 05:37:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:04 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:37:04 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 05:37:04 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 05:37:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:04 INFO - 'HOME': '/Users/cltbld', 05:37:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:04 INFO - 'LOGNAME': 'cltbld', 05:37:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:04 INFO - 'MOZ_NO_REMOTE': '1', 05:37:04 INFO - 'NO_EM_RESTART': '1', 05:37:04 INFO - 'PAGER': '/bin/cat', 05:37:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:04 INFO - 'PWD': '/builds/slave/test', 05:37:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:04 INFO - 'SHELL': '/bin/bash', 05:37:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:04 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:04 INFO - 'USER': 'cltbld', 05:37:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:04 INFO - 'XPC_FLAGS': '0x0', 05:37:04 INFO - 'XPC_SERVICE_NAME': '0', 05:37:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:04 INFO - Downloading/unpacking blobuploader==1.2.4 05:37:04 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 05:37:04 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 05:37:04 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 05:37:04 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 05:37:04 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 05:37:04 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 05:37:07 INFO - Downloading blobuploader-1.2.4.tar.gz 05:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:37:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37: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 05:37:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:37:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 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 05:37:08 INFO - Downloading docopt-0.6.1.tar.gz 05:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:37:08 INFO - Installing collected packages: blobuploader, requests, docopt 05:37:08 INFO - Running setup.py install for blobuploader 05:37:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:37:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:37:08 INFO - Running setup.py install for requests 05:37:09 INFO - Running setup.py install for docopt 05:37:09 INFO - Successfully installed blobuploader requests docopt 05:37:09 INFO - Cleaning up... 05:37:09 INFO - Return code: 0 05:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:09 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')]} 05:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:09 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')]} 05:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:09 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:37:09 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 05:37:09 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 05:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:09 INFO - 'HOME': '/Users/cltbld', 05:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:09 INFO - 'LOGNAME': 'cltbld', 05:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:09 INFO - 'MOZ_NO_REMOTE': '1', 05:37:09 INFO - 'NO_EM_RESTART': '1', 05:37:09 INFO - 'PAGER': '/bin/cat', 05:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:09 INFO - 'PWD': '/builds/slave/test', 05:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:09 INFO - 'SHELL': '/bin/bash', 05:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:09 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:09 INFO - 'USER': 'cltbld', 05:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:09 INFO - 'XPC_FLAGS': '0x0', 05:37:09 INFO - 'XPC_SERVICE_NAME': '0', 05:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-v6VrkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-YkFpWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:09 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-BKDHsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-z1jwSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-7VK5Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-ZQ2JVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-xKQKXD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-hGFCf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-_PT7uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-dob4ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-dGPcEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-qHtXcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:10 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-EW6_Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:11 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-60b1jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:11 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-zRHlfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:11 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-KhXfWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:11 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-otgALt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:37:11 INFO - Running setup.py install for manifestparser 05:37:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:37:11 INFO - Running setup.py install for mozcrash 05:37:11 INFO - Running setup.py install for mozdebug 05:37:11 INFO - Running setup.py install for mozdevice 05:37:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozfile 05:37:12 INFO - Running setup.py install for mozhttpd 05:37:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozinfo 05:37:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozInstall 05:37:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for mozleak 05:37:12 INFO - Running setup.py install for mozlog 05:37:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:37:12 INFO - Running setup.py install for moznetwork 05:37:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozprocess 05:37:13 INFO - Running setup.py install for mozprofile 05:37:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozrunner 05:37:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:37:13 INFO - Running setup.py install for mozscreenshot 05:37:13 INFO - Running setup.py install for moztest 05:37:13 INFO - Running setup.py install for mozversion 05:37:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:37:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:37:14 INFO - Cleaning up... 05:37:14 INFO - Return code: 0 05:37:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:14 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:37:14 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 05:37:14 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 05:37:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:14 INFO - 'HOME': '/Users/cltbld', 05:37:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:14 INFO - 'LOGNAME': 'cltbld', 05:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:14 INFO - 'MOZ_NO_REMOTE': '1', 05:37:14 INFO - 'NO_EM_RESTART': '1', 05:37:14 INFO - 'PAGER': '/bin/cat', 05:37:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:14 INFO - 'PWD': '/builds/slave/test', 05:37:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:14 INFO - 'SHELL': '/bin/bash', 05:37:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:14 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:14 INFO - 'USER': 'cltbld', 05:37:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:14 INFO - 'XPC_FLAGS': '0x0', 05:37:14 INFO - 'XPC_SERVICE_NAME': '0', 05:37:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Nt4L1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-PreTfG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-qdjNrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-Le5Oui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-E0iW_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-9NJq4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:37:14 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)) 05:37:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:37:14 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-wtQHYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-zyVDnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-60Ynk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-iO4uEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-BisVrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-VmWGNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-4yAAC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-9z2mhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-H5HVxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-XmcNIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:37:15 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)) 05:37:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:37:15 INFO - Running setup.py (path:/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/pip-mNesll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:37:16 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)) 05:37:16 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)) 05:37:16 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)) 05:37:16 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)) 05:37:16 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)) 05:37:16 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)) 05:37:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:37:16 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 05:37:16 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 05:37:16 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 05:37:16 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 05:37:16 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 05:37:16 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 05:37:18 INFO - Downloading blessings-1.6.tar.gz 05:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:37:18 INFO - Installing collected packages: blessings 05:37:18 INFO - Running setup.py install for blessings 05:37:18 INFO - Successfully installed blessings 05:37:18 INFO - Cleaning up... 05:37:18 INFO - Return code: 0 05:37:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:37:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:19 INFO - Reading from file tmpfile_stdout 05:37:19 INFO - Current package versions: 05:37:19 INFO - blessings == 1.6 05:37:19 INFO - blobuploader == 1.2.4 05:37:19 INFO - docopt == 0.6.1 05:37:19 INFO - functools32 == 3.2.3-2 05:37:19 INFO - jsonschema == 2.5.1 05:37:19 INFO - manifestparser == 1.1 05:37:19 INFO - mozInstall == 1.12 05:37:19 INFO - mozcrash == 0.17 05:37:19 INFO - mozdebug == 0.1 05:37:19 INFO - mozdevice == 0.48 05:37:19 INFO - mozfile == 1.2 05:37:19 INFO - mozhttpd == 0.7 05:37:19 INFO - mozinfo == 0.9 05:37:19 INFO - mozleak == 0.1 05:37:19 INFO - mozlog == 3.2 05:37:19 INFO - moznetwork == 0.27 05:37:19 INFO - mozprocess == 0.22 05:37:19 INFO - mozprofile == 0.28 05:37:19 INFO - mozrunner == 6.11 05:37:19 INFO - mozscreenshot == 0.1 05:37:19 INFO - mozsystemmonitor == 0.3 05:37:19 INFO - moztest == 0.7 05:37:19 INFO - mozversion == 1.4 05:37:19 INFO - psutil == 3.1.1 05:37:19 INFO - requests == 1.2.3 05:37:19 INFO - wsgiref == 0.1.2 05:37:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:19 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:37:19 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 05:37:19 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 05:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:19 INFO - 'HOME': '/Users/cltbld', 05:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:19 INFO - 'LOGNAME': 'cltbld', 05:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:19 INFO - 'MOZ_NO_REMOTE': '1', 05:37:19 INFO - 'NO_EM_RESTART': '1', 05:37:19 INFO - 'PAGER': '/bin/cat', 05:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:19 INFO - 'PWD': '/builds/slave/test', 05:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:19 INFO - 'SHELL': '/bin/bash', 05:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:19 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:19 INFO - 'USER': 'cltbld', 05:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:19 INFO - 'XPC_FLAGS': '0x0', 05:37:19 INFO - 'XPC_SERVICE_NAME': '0', 05:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 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)) 05:37:19 INFO - Cleaning up... 05:37:19 INFO - Return code: 0 05:37:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:37:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:37:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:37:19 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 0x10c1eba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c280618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f989a4767c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, '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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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 05:37:19 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 05:37:19 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 05:37:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:19 INFO - 'HOME': '/Users/cltbld', 05:37:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:19 INFO - 'LOGNAME': 'cltbld', 05:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:19 INFO - 'MOZ_NO_REMOTE': '1', 05:37:19 INFO - 'NO_EM_RESTART': '1', 05:37:19 INFO - 'PAGER': '/bin/cat', 05:37:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:19 INFO - 'PWD': '/builds/slave/test', 05:37:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:19 INFO - 'SHELL': '/bin/bash', 05:37:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:19 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:19 INFO - 'USER': 'cltbld', 05:37:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:19 INFO - 'XPC_FLAGS': '0x0', 05:37:19 INFO - 'XPC_SERVICE_NAME': '0', 05:37:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:37:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:37:19 INFO - Cleaning up... 05:37:19 INFO - Return code: 0 05:37:19 INFO - Running post-action listener: _resource_record_post_action 05:37:19 INFO - Running post-action listener: _start_resource_monitoring 05:37:19 INFO - Starting resource monitoring. 05:37:19 INFO - ##### 05:37:19 INFO - ##### Finished create-virtualenv step (success) 05:37:19 INFO - ##### 05:37:19 INFO - ##### 05:37:19 INFO - ##### Running install step. 05:37:19 INFO - ##### 05:37:19 INFO - Running pre-action listener: _resource_record_pre_action 05:37:19 INFO - Running main action method: install 05:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:37:19 INFO - Reading from file tmpfile_stdout 05:37:19 INFO - Detecting whether we're running mozinstall >=1.0... 05:37:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:37:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:37:20 INFO - Reading from file tmpfile_stdout 05:37:20 INFO - Output received: 05:37:20 INFO - Usage: mozinstall [options] installer 05:37:20 INFO - Options: 05:37:20 INFO - -h, --help show this help message and exit 05:37:20 INFO - -d DEST, --destination=DEST 05:37:20 INFO - Directory to install application into. [default: 05:37:20 INFO - "/builds/slave/test"] 05:37:20 INFO - --app=APP Application being installed. [default: firefox] 05:37:20 INFO - mkdir: /builds/slave/test/build/application 05:37:20 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'] 05:37:20 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 05:37:54 INFO - Reading from file tmpfile_stdout 05:37:54 INFO - Output received: 05:37:54 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:37:54 INFO - Running post-action listener: _resource_record_post_action 05:37:54 INFO - ##### 05:37:54 INFO - ##### Finished install step (success) 05:37:54 INFO - ##### 05:37:54 INFO - ##### 05:37:54 INFO - ##### Running run-tests step. 05:37:54 INFO - ##### 05:37:54 INFO - Running pre-action listener: _resource_record_pre_action 05:37:54 INFO - Running main action method: run_tests 05:37:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:37:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:37:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:37:54 INFO - 2016-07-06 05:37:54.199 screenresolution[1911:10010] starting screenresolution argv=screenresolution get 05:37:54 INFO - 2016-07-06 05:37:54.202 screenresolution[1911:10010] Display 0: 1600x1200x32@60 05:37:54 INFO - 2016-07-06 05:37:54.207 screenresolution[1912:10013] starting screenresolution argv=screenresolution list 05:37:54 INFO - Available Modes on Display 0 05:37:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:37:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:37:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:37:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:37:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:37:54 INFO - Intel Iris: 05:37:54 INFO - Chipset Model: Intel Iris 05:37:54 INFO - Type: GPU 05:37:54 INFO - Bus: Built-In 05:37:54 INFO - VRAM (Dynamic, Max): 1536 MB 05:37:54 INFO - Vendor: Intel (0x8086) 05:37:54 INFO - Device ID: 0x0a2e 05:37:54 INFO - Revision ID: 0x0009 05:37:54 INFO - Displays: 05:37:54 INFO - Display: 05:37:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:37:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:37:54 INFO - Display Serial Number: 1600x1200 60 05:37:54 INFO - Main Display: Yes 05:37:54 INFO - Mirror: Off 05:37:54 INFO - Online: Yes 05:37:54 INFO - Rotation: Supported 05:37:54 INFO - Return code: 0 05:37:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:37:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:37:54 INFO - Python 2.7.3 05:37:54 INFO - Return code: 0 05:37:54 INFO - grabbing minidump binary from tooltool 05:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:37:54 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 0x10c14fd30>, '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 0x10beb4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c147b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:37:54 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 05:37:54 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 05:37:54 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 05:37:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:37:54 INFO - Return code: 0 05:37:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:37:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:37:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:37:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:37:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:37:54 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--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 05:37:54 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0118 --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 05:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ntt1GMpCQ4/Render', 05:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:37:54 INFO - 'HOME': '/Users/cltbld', 05:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:37:54 INFO - 'LOGNAME': 'cltbld', 05:37:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:37:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:37:54 INFO - 'MOZ_NO_REMOTE': '1', 05:37:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:37:54 INFO - 'NO_EM_RESTART': '1', 05:37:54 INFO - 'PAGER': '/bin/cat', 05:37:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:37:54 INFO - 'PWD': '/builds/slave/test', 05:37:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:37:54 INFO - 'SHELL': '/bin/bash', 05:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EAOCZcqG20/Listeners', 05:37:54 INFO - 'TMPDIR': '/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/', 05:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:37:54 INFO - 'USER': 'cltbld', 05:37:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:37:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:37:54 INFO - 'XPC_FLAGS': '0x0', 05:37:54 INFO - 'XPC_SERVICE_NAME': '0', 05:37:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:37:54 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0118', '--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 05:37:54 INFO - mozversion application_buildid: 20160706030233 05:37:54 INFO - mozversion application_changeset: 95ffbc4ff63584631c408e8d9912961fcf68bb09 05:37:54 INFO - mozversion application_display_name: Nightly 05:37:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:37:54 INFO - mozversion application_name: Firefox 05:37:54 INFO - mozversion application_remotingname: firefox 05:37:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:37:54 INFO - mozversion application_vendor: Mozilla 05:37:54 INFO - mozversion application_version: 50.0a1 05:37:54 INFO - mozversion platform_buildid: 20160706030233 05:37:54 INFO - mozversion platform_changeset: 95ffbc4ff63584631c408e8d9912961fcf68bb09 05:37:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:37:54 INFO - mozversion platform_version: 50.0a1 05:37:54 INFO - using testdate: 1467808674 05:37:54 INFO - actual date: 1467808674 05:37:54 INFO - starting webserver on 'localhost:49436' 05:37:54 INFO - SUITE-START | Running 2 tests 05:37:54 INFO - TEST-START | dromaeo_css 05:37:54 INFO - operating with platform_type : mac_ 05:37:54 INFO - Initialising browser for dromaeo_css test... 05:37:54 INFO - TEST-INFO | started process 1922 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpFJdHzz/profile http://localhost:49436/getInfo.html) 05:37:57 INFO - PROCESS | 1922 | __metrics Screen width/height:1600/1200 05:37:57 INFO - PROCESS | 1922 | colorDepth:24 05:37:57 INFO - PROCESS | 1922 | Browser inner width/height: 1024/689 05:37:57 INFO - PROCESS | 1922 | __metrics 05:37:58 ERROR - PROCESS | 1922 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 05:37:58 INFO - TEST-INFO | 1922: exit 0 05:37:58 INFO - Browser initialized. 05:37:58 INFO - Running cycle 1/1 for dromaeo_css test... 05:37:58 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpFJdHzz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:10 INFO - PROCESS | 1926 | RSS: Main: 255606784 05:38:10 INFO - PROCESS | 1926 | 05:39:00 INFO - PROCESS | 1926 | 1467808740449 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] 05:41:12 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49436/tests/dromaeo/cssquery-ext.html) 05:41:14 INFO - PROCESS | 1926 | RSS: Main: 269709312 05:41:14 INFO - PROCESS | 1926 | 05:44:16 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-ext.html (next: http://localhost:49436/tests/dromaeo/cssquery-jquery.html) 05:44:17 INFO - PROCESS | 1926 | RSS: Main: 278409216 05:44:17 INFO - PROCESS | 1926 | 05:47:18 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49436/tests/dromaeo/cssquery-mootools.html) 05:47:19 INFO - PROCESS | 1926 | RSS: Main: 282996736 05:47:19 INFO - PROCESS | 1926 | 05:50:21 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49436/tests/dromaeo/cssquery-prototype.html) 05:50:22 INFO - PROCESS | 1926 | RSS: Main: 282320896 05:50:22 INFO - PROCESS | 1926 | 05:53:24 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49436/tests/dromaeo/cssquery-yui.html) 05:53:25 INFO - PROCESS | 1926 | RSS: Main: 285450240 05:53:25 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-yui.html (next: http://localhost:49436/tests/dromaeo/cssquery-dojo.html) 05:56:28 INFO - PROCESS | 1926 | RSS: Main: 285597696 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | __start_tp_report 05:56:28 INFO - PROCESS | 1926 | _x_x_mozilla_page_load 05:56:28 INFO - PROCESS | 1926 | _x_x_mozilla_page_load_details 05:56:28 INFO - PROCESS | 1926 | |i|pagename|runs| 05:56:28 INFO - PROCESS | 1926 | |0;dojo.html;3039.7872148949573;3360.680735330143;3391.4404123319646;3392.7625066245373;3404.965950340496;5104.872378190547;5501.532369748571;5770.163326317682;5846.064629659255;5846.532277417807;5638.323401191863;5845.941540584593;5900.734466948987;5915.792947246847;5965.791197308095;4256.255155347817;5196.350456192976;5213.817516386927;5229.37247530295;5358.839234822942;5336.519713225809;5336.839894803143;5365.08793505105;5378.811741589046;5408.323959505062;5182.144946083929;5212.739363031871;5253.842384728464;5291.708956007418;5307.867303317409;5283.28675628789;5286.81496147633;5286.995470860525;5310.256564081032;5329.8934021319355;5232.6860388376435;5245.449227831099;5259.8422047338645;5282.313299271109;5331.253624492574;5669.518090962273;5760.596758226926;5771.307443106854;5855.590108692393;5869.1196320551835;4670.976645116787;4716.198246298138;5605.775768969236;6144.8771024579255;6201.441870231701;6270.153529273535;6294.276158241815;6297.275813281485;6304.085907543426;6311.147995020659;5399.541039011649;5810.273715785527;5862.443067908542;5902.350741418398;5932.288125424977;6365.649889256136;6376.936230637634;6383.234011918599;6384.712687928962;6403.839904002344;6187.071939209065;6217.098520714561;6224.688765561795;6229.377062293825;6252.062190671345;5145.253938178943;6131.132004888128;6136.243373036893;6181.103739957681;6184.567080304426;6118.510519158456;6145.170401995673;6192.473639740582;6195.2255968004;6210.596311239755;6134.110553969649;6166.691665416712;6183.474404675563;6211.130441738161;6212.658303793335;4902.460729319772;4976.4525902150735;5008.949910500921;5033.773480193327;5034.974825125924;4461.219286624828;4466.754328511898;4489.753063581469;4489.910201796011;4500.144972455223;5922.526197904157;6006.639601623917;6021.458068773832;6022.5784195105925;6027.095935609694;5263.289455923478;6123.038605230386;6129.23653806838;6186.907196392058;6216.720247588869;5963.522918166536;5996.130561068708;6000.8799824004145;6012.518998480111;6032.577719559677;5407.729613519387;5499.230107784913;5515.420880807537;5540.2243685884005;5554.055810512223;6355.968220158869;6399.360063993563;6427.839304017437;6499.837504062436;6543.247526534509;6282.465990390685;6304.275008374096;6315.179026726496;6316.399942005502;6318.178636777189;6224.688765561613;6358.713857876499;6481.384268494486;6498.090267362668;6503.382178693017;6124.899720462962;6164.815055548341;6214.4407003369915;6214.8135555933395;6241.126242325987;5793.159991801081;6283.748650053946;6290.591111577916;6300.810975670737;6302.117703521419;5882.852928676817;6069.666168360783;6156.891759483336;6206.72069756853;6228.439440450381;6105.611380716617;6106.2061931948565;6107.175531303395;6134.803982731443;6160;4727.338172655762;5380.354357477127;5850.297964244318;6120.969395152996;6159.538034647509;6098.451139397298;6105.206323177958;6143.573288551087;6193.38066193377;6198.535109866868;6114.145302971568;6122.5506807263955;6124.667191846973;6129.00650620687;6143.174139895698 05:56:28 INFO - PROCESS | 1926 | |1;ext.html;467.11481742098726;525.5112745147012;527.1118165890474;536.3965538768884;551.8316913341429;39739.99999999996;42170.78914605427;42238.366424503656;42327.57672423275;42410.78794606031;42536.787316063455;42988.140237195315;43447.34828977568;43531.56468435315;43741.7812910935;9487.857682134756;9615.56729947154;9649.517524123801;9772.218222542215;9774.973627769088;8303.46027508213;9627.614895404175;9703.514824258795;9712.66005689801;9717.028297170296;9638.855417168748;9714.22286217101;9742.464164470952;9753.170980466668;9762.560684769202;9690.999999999965;9715.174210192072;9734.318597698164;9736.464494452837;9747.268954828345;8480.812686223933;9468.100530449596;9567.37812042215;9676.274279429;9691.563879625433;41175.1764964699;41203;41433.58566414328;41633.37549936753;41674.58325416768;3569.1434055826676;3640.9635903640888;3660.0483874192637;3720.9255814883822;3753.474513568103;31835.681643183503;32545.186370340693;33261.16847078843;33454.33091338184;34037.659623403946;3385.2044769479153;3387.5426817379584;3389.915252118692;3390.1524618845287;3504.176518518146;488572;491512;497942;498168;498702.9999999964;34174.48738268928;69286.65356673184;69441.65279173572;70102.64948675224;70162.29837701557;37169.25661486809;37375;37726;37757.24485510274;37810.43284350737;15441.227938603024;15535.533933981998;15656.843431565538;15682.686346273238;15682.76475852863;11293.887061129448;12835.422405991752;12865.163764355288;13074.411651475706;13254.734905302033;7416.147143078507;7599.708049631576;8161.63272652732;8203.507789532528;8226;3380.797152170878;3407.1311815486893;3417.5215469834243;3426.7087297579487;3428.400029994741;977.8630991661173;1014.7868947520956;1019.7858449725641;1043.6921108272925;1156.8380426740264;26417.735822641913;26530;30873;31304;32750.67249327524;960.7598100474881;1076.6864425400997;1086.8641419822522;1102.9338239705644;1153.7058050197313;14114.082584631966;16416.589585260463;16503.6699266014;16589.91705041491;16666.583340415957;614115;699288;711625;712357;713475;61628.07557886635;61887.76224475575;62266.68866655638;62279.06581401283;62567.374326257064;1199.7600479904054;1411.386047069528;1437.8130842990554;1444.6388402899274;1448.217962300346;30509.32198729091;30522.694773051986;30559.388812224075;31212.843935780176;31438.52842207323;49474.75262623664;49507.75246123746;49724.75688107826;53148.95084966922;53950.73024634852;604119;610790;616341;617117;618847;27909;27983.720162798112;28885.133445996653;29021.419571608873;29032.12903612895;49484.76288092826;50066.49933500764;50134.74663133305;50247.748761255956;50643.24035139402;33876.322473550885;41078.58921410867;41343.58656413518;42026.485894686375;42113.789431052646;33638;36022.27955440824;41457.79271103625;41488.79255603703;41838.79080604578;33800.3239935195;39027.219455611295;39446.81659550218;39598.81203563898;39609.80195099006;35336.46995295124;35918;36314.4552831713;36464.63535364719;36577.085572860895;25989.0903818373;26554;26566.867165664047;26615.46769064569;26997 05:56:28 INFO - PROCESS | 1926 | |2;jquery.html;386.8510623409986;388.3611459149699;389.68240883679783;394.9249642567912;412.4164307504881;15000.249987500636;20789.584208315842;21139.365819025454;21698.566028679415;21735.45661358467;20274.18903243872;20887.791122088776;21103.68344474834;21184;21606;5079.771410286537;5994.8801023979495;6046.576739628228;6051.425114614105;6150.600210986271;6028.4574388305045;6037.426444487766;6062.4543791058795;6153.138560601519;6162.691865406734;5987.042073268278;6103.29812071613;6103.633781973073;6118.082287656843;6133.601315914473;5939.821805345847;5951.58338916276;5956.612820166675;6106.328303886569;6110.725017374229;5290.021346050954;5310.176922577007;5311.681299122065;5315.255864179018;5324.5740340772645;25052.373690657696;26107.738922610723;26138.085167019064;26337.604935925978;26352.341191470176;2417.9395515112087;2559.590465525507;2754.256350785277;2773.653293338333;3205.599300087489;15415;15437.599681020667;15594.220288985618;15943;16297.674046519003;1828.9634207315912;1844.9558228922251;1897.1083590712344;1902.5338791995912;1929.507975466261;89440.55279723559;113842.43078784636;114040;119060.40469797682;123026;8861.468311901306;10755.032047115797;11077.556897724162;11159.832602510969;11185.545879035673;13394.531191408254;13538.526151584647;13570.050096493349;13585;13664.316784160752;7640.503367281221;8587.82824343522;8620.094890036582;8699.826003479895;8727.694530691522;8662.696805611773;8763.868541971875;8891.333150013776;8944.821103578022;9010.189082982562;6648.966755166193;6702.128723265944;6754.729810807513;6767.39093481589;6791.524593278423;1579.4156162219822;1582.2009885007997;1838.8620853436046;1861.5625328047897;1869.5699989002333;755.8866170074423;935.9017303183068;956.3783540698602;1008.2387797213057;1029.3669393323203;20297.782133071767;20744.170233190503;22787.772122278566;22793;22853.857307134578;969.1277849935115;981.5092453773113;986.1716158426956;1005.9094681478703;1041.760305236781;11497.942510287396;12003.63989080329;12017.399130043637;12022.458989345501;12023.579174728842;592467;598689;607465;620435;620724;69468;96234.03765962251;100797.46411411504;103277;107325;965.3676841668578;988.2785566536324;995.3430735714394;1002.3935519011039;1004.0762498501397;14632;20047.997600119645;20083.497912552302;20135.39593812188;20137.99310034522;53183.73408133089;53414.73292633512;53951.795543513;54033.459665404414;55899.720501397234;77623;81191;82883.3423331518;88936;90512;7753.573553454388;7822.295993360625;7850.528968261694;7998.720044798404;8183.754487365389;11244.9437752814;11466.942665286953;12517.74964500723;13337.19976801395;13614.115082519604;11496.770064598828;11652.94173529127;11688.590899318484;11737.35444550558;11779.823302650639;10850.67447976562;11491.023263022402;11571.247868888495;11669.35818529989;12022.63932082039;11243.887561124284;11747.412629368326;11755.118366122404;11972.16194866351;12014.819777703167;8130.63412146443;8161.979752530933;8216.46592971455;8298.087210406971;8398.916010839814;11258.549658013915;11331.206815522833;11592.188546801643;11661.825072624088;11818.881811182122 05:56:28 INFO - PROCESS | 1926 | |3;mootools.html;1555.7277476441623;1573.2291177323116;1687.4768821665277;1769.7787776527925;1848.4362269507794;7562.773116806491;7862.0958589762195;8635.481871087739;9102.499362535058;9115.08849115089;8708.825823483543;8806.86789698155;8888.244499217575;8905.688300909469;8912.287017038638;2073.699313599535;2377.583922813509;2383.5590415773136;2404.9398765030837;2414.070582825616;2384.642303654457;2387.2002879035545;2398.436367453647;2417.3199626259757;2433.4646377796857;2403.531311394279;2409.5301416223842;2411.2766170148975;2425.9757402426017;2467.259822053377;2363.6218205087275;2372.893219805113;2384.546936082139;2396.7123945126523;2403.567357875582;2340.941476463102;2356.929292121239;2377.679013333195;2398.5802484565133;2408.650745641872;8756.649734010633;8766.912330876738;8864.290856731446;8963.731088067369;9014.954925225398;5201.531862132389;5344.171653393731;5363.034653762321;5409.080456322435;5442.210879422501;3547.6984456321243;3690.5940346561856;3747.4378843173467;3757.887263382103;3771.641694039062;1079.4872435593109;1080.5893760371087;1080.6325849211305;1097.8627671541058;1106.0322218059198;11513.30920144794;11672.824907626393;11798.702142764203;11821.645350639494;11833.171677982544;4463.419755431838;4557.043020965568;4676.438827340741;4689.320048592935;4695.530446955346;7924.920750792534;9305.395149315409;9328;9330.720078397659;9345.766355841159;5219.608529360313;5320.361556613231;5321.574274058066;5325.3875804282225;5325.680459172462;4421.845235416809;4762.333273341735;4924.778384972685;4951.529604687549;4990.5508504234795;3830.272248272819;3856.2094770571966;3916.570451785135;3959.6832253419657;3968.6626636735623;1189.120051162134;1195.1992165249303;1195.2589394575245;1204.8915597596083;1207.0024110097802;777.7277952716504;802.7471346525825;881.4182639457927;911.3757076402685;969.7236287658125;6120.510359171345;6121.755129794848;6140.508759299245;6203.565750397519;6314.463270621956;898.3127907151035;906.1482206725657;913.6117150211134;936.6721647423484;978.617067440784;3915.6280153385383;4142.233686767958;4168.708190426702;4184.9746812030635;4189.141226048653;8870.467771933705;10410.843837342445;10581.206409519316;10745.032947034648;10821.080208182235;10458.738531536772;10547.892471290557;10704.94647526773;10716.35701857891;10771.299865508718;7919.5248285101925;8227.218414250636;8275.95862020686;8288.792780180424;8292;5835.183074369506;5933.3769954154195;6033.668148251712;6052.9407353713805;6056.424639659225;9915.900840991499;9956.004399559986;9980.950095249478;10004.84992725095;10068.748281293027;9631.855522167314;9940.204783617148;10053.949730251303;10159.542820572944;10184;6810.761623343159;7406.962965185139;7543.057117860268;7619.047619047619;7630.694772209049;8419.62111704987;8426.4944103354;8465.788355291166;8522.48865068098;8536.658533658585;7427.851442971219;7572.924270757222;7643.464957452925;7696.384289256734;7761.107472640493;7443.516171448839;7448.851022979618;7494.576030554177;7528.811779705551;7580.620968951641;7083.468739844429;7143.785686429415;7172.820679482846;7172.892406613801;7180.712771489082;4449.710768800018;4937.407511098691;5047.520485553867;5082.313887625123;5097.311862898461;5079.111155547838;5107.233914912793;5127.128388173945;5153.123968925217;5154.561862241601 05:56:28 INFO - PROCESS | 1926 | |4;prototype.html;294.512581677324;314.64445176950045;317.5142032689984;324.3027490894578;324.6396499885129;5787.726700125976;5806.693493963856;5825.126231065342;5866.677332746697;5892.852678683035;5735.369109397973;5746;5749.786332262078;5788.739506722197;5804.796832110877;3714.108613932657;4178.435911151986;4287.48550173978;4299.183155200518;4300.440942677447;3698.94836759673;4231.217224813419;4271.914561708764;4322.84870029549;4329.870103896872;4146.543880173179;4287.614114729674;4296.248156572603;4306.289462238727;4317.352397140438;3508.8421021054114;4080.979595102035;4273.551277115889;4283.957160428387;4294.033842385438;3229.935401291961;3681.37416639172;3709.2766910452474;3713.7771733696063;3728.229091181694;4121.52602450719;5604;5615.455749668874;5636.605437619368;5645.971770141123;4805.198050730976;5015.84952451427;5030.622703297231;5035.395752509722;5048.343715317022;4580.816767329303;4844.5155484451625;6015.368386319461;6047.516198704093;6060.939335616249;3119.703628155344;4106.425100485934;4140.3375459926565;4176.686748493875;4247.936280955788;5643.661380317153;5755.913661295084;6100.23747031621;6388.904166437507;6435.517336199804;3690.3357395669036;4144.274751918402;4158.896027599274;4181.60274773896;4199.832006719758;3846.7307288489537;4024.9798751006642;4232.36514522824;4259.574042595777;4293.119910418419;4481.901934026185;4751.904961900812;5009.398872135294;5051.949480505222;5061.316722242524;5447.400785913546;5897.144913987448;5977.641341519436;5996.280446346466;6109.75560977556;1298.8960883129328;1428.8499707530768;1453.8037364955808;1454.905431146972;1463.6926245488567;831.6091437024588;845.3913182508584;911.3392790227165;925.7778133247972;966.989495976706;3997.520297564253;5036.899262014739;5199.63602547818;5257.842264732064;5624.6625202487985;6126.754929802758;6225.470834978987;6241.127661701471;6272.937270627326;6277.515978631903;4870.8811666925;5634.6337488063145;5661.395757951388;5838.2702162229725;5854.297484301911;2969.9109026729234;3163.7469002479747;3224.951625725616;3298.4887342461957;3364.896939412867;5836.702263221267;6075.936711075544;6323.430891219812;6388.968055159788;6484.837879053061;5666.150077488327;5904.763809447574;6103.05402662588;6507.284198738135;6517.51118666102;5748.45389687979;6596.86806263872;6600.86798264032;6607.522179182806;6617.933820661732;5513.022967597452;5527.309086364205;5939.792107276225;6319.936800631935;6354.110424540476;5232;5548.556115510669;6219.502439804895;6258.593191442542;6273.71768270438;4997.5002499749735;6014.218151640259;6434.522708757068;6513.7068831903625;6580.967095164685;3728.012076799596;3930.6855451563233;4001.3997900315185;4029.3150164472695;4031.979840100898;6268.749250029948;6272.717727702356;6284.780032698834;6295.779647712308;6308.243010838729;5264.9210261846865;5288.867778305573;5680.4319568042865;5770.6249093808765;5994.88010239784;5097.770600323069;5171.095058364695;5718.685472299064;5934.525237980864;6120.8775824484155;5636.549076073986;5640.251522028185;5922.822315330547;5967.224260846062;5982.4316689914385;6026;6052.364501727431;6091.939080609137;6100.352904715791;6112.694365281807;5101.724568857786;5509.118541033416;5944.910826337522;6001.159837622824;6004.909926351195 05:56:28 INFO - PROCESS | 1926 | |5;yui.html;603.2851071480299;653.6731634182909;787.4645241235958;798.2376830127229;812.3501199040766;14556.344964476597;14582.56252312431;15048.021878577885;15203.315850786714;15988.280527376266;12663.683407914783;13867.098638588484;14684.265786710648;14742.262886855668;14842.628934276649;708.5819366573746;760.5360729954737;852.6333676519095;878.7627340618029;895.5656506594297;885.1104639836955;899.3344924755667;900.4462255712755;902.2871931174365;903.2954295649371;923.2198792020732;958.8322043642335;959.8512230604233;963.2727290895364;966.3235734985539;915.7893684452547;917.1928702741578;923.2475532441039;955.2835373469898;956.1490273656451;699.9650017499105;711.4415184080524;712.868119397913;714.4427346669606;718.7484380466847;15550.222488875625;15917;16106.919465402716;16140.75788863168;16143.919280403641;11720.824187637192;13620.863791362059;13621.591352259447;13766.65583360424;13883.652908677263;12613.369331533386;12715.682107947283;13413.597592072254;13683.24742139182;13814.516491922734;4553.704009239389;4578.862634120982;4820.39745031871;4864.8297309594345;4865.95134048662;76605.08487287862;111685.44157279162;112594;113363;113923;11095.278806877688;11182.384968826793;11195.664130076111;11200.831987520194;11250.831237531444;21326.466838328855;21332.36002919915;21348.89325553362;21354.572908542053;21416.464588385104;7705.537667739954;7958.164392738795;7966.601669916481;7973.760787176394;8101.959490202511;4041.2321658884716;4457.888552786141;4457.955420445819;4481.282994720894;4672.088942656217;3459.41189997701;3555.235624340779;3602.063463499509;3608.1520842601967;3608.260306637133;587.9970600146972;667.1160712056447;673.8584897171551;679.0527214535695;681.7204945972227;641.4387411015362;652.4356431686557;656.6749459017722;673.4511373230802;679.6431873266574;9356.95321523388;9431.123507330192;9432.952835235918;9681.579605098725;9872.137080246648;670.3363669966795;681.6727970574152;704.2183176673888;706.4030893894651;707.1726080485844;4481.932771008437;4692.4603670577635;4710.858674239778;4712.293156026623;4719.161569268172;142447.2877635605;151317;151630;152859;152923;131192;132926;133179.33410332887;133616;136655;112202;112832.99999999836;112919;113345;114576;8546.059933407196;8961.820763584561;8981.910180898107;9118.179363857285;9208.677696280598;38624.613753862104;53830;62527.37472625398;63315.683421582595;64692;89200;90594;92236;93258;93364.53317733368;11939.582114625946;11963.521459141884;11999.460024299102;12321.507139714311;12388.876111238773;13152.079354445097;13386.19682819034;13394.735005931092;13425.395857186255;13459.441969285675;11375.658730238107;11683.523019274606;12179.439437948482;12397.690057748629;13076.346182691017;12370.690732731753;12652.936735316265;12838.358082096045;12903.548375807177;12923.741525169256;12016.391887912272;12154.453049612965;12393.876061239633;12456.626301210616;12543.93728031354;10541.73645658834;10799.622013229498;10910.072643825046;11021.118310535297;11040.889591103985;9869.81562212539;10541.789164216827;10696.946515267375;10739.409332486788;10748.570057197625 05:56:28 INFO - PROCESS | 1926 | __end_tp_report 05:56:28 INFO - PROCESS | 1926 | __start_cc_report 05:56:28 INFO - PROCESS | 1926 | _x_x_mozilla_cycle_collect,441 05:56:28 INFO - PROCESS | 1926 | __end_cc_report 05:56:28 INFO - PROCESS | 1926 | __startTimestamp1467809788575__endTimestamp 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | ------- Summary: start ------- 05:56:28 INFO - PROCESS | 1926 | Number of tests: 6 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | [#0] dojo.html Cycles:165 Average:5755.52 Median:6022.58 stddev:670.38 (11.1%) stddev-sans-first:637.69 05:56:28 INFO - PROCESS | 1926 | Values: 3039.8 3360.7 3391.4 3392.8 3405.0 5104.9 5501.5 5770.2 5846.1 5846.5 5638.3 5845.9 5900.7 5915.8 5965.8 4256.3 5196.4 5213.8 5229.4 5358.8 5336.5 5336.8 5365.1 5378.8 5408.3 5182.1 5212.7 5253.8 5291.7 5307.9 5283.3 5286.8 5287.0 5310.3 5329.9 5232.7 5245.4 5259.8 5282.3 5331.3 5669.5 5760.6 5771.3 5855.6 5869.1 4671.0 4716.2 5605.8 6144.9 6201.4 6270.2 6294.3 6297.3 6304.1 6311.1 5399.5 5810.3 5862.4 5902.4 5932.3 6365.6 6376.9 6383.2 6384.7 6403.8 6187.1 6217.1 6224.7 6229.4 6252.1 5145.3 6131.1 6136.2 6181.1 6184.6 6118.5 6145.2 6192.5 6195.2 6210.6 6134.1 6166.7 6183.5 6211.1 6212.7 4902.5 4976.5 5008.9 5033.8 5035.0 4461.2 4466.8 4489.8 4489.9 4500.1 5922.5 6006.6 6021.5 6022.6 6027.1 5263.3 6123.0 6129.2 6186.9 6216.7 5963.5 5996.1 6000.9 6012.5 6032.6 5407.7 5499.2 5515.4 5540.2 5554.1 6356.0 6399.4 6427.8 6499.8 6543.2 6282.5 6304.3 6315.2 6316.4 6318.2 6224.7 6358.7 6481.4 6498.1 6503.4 6124.9 6164.8 6214.4 6214.8 6241.1 5793.2 6283.7 6290.6 6300.8 6302.1 5882.9 6069.7 6156.9 6206.7 6228.4 6105.6 6106.2 6107.2 6134.8 6160.0 4727.3 5380.4 5850.3 6121.0 6159.5 6098.5 6105.2 6143.6 6193.4 6198.5 6114.1 6122.6 6124.7 6129.0 6143.2 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | [#1] ext.html Cycles:180 Average:72368.54 Median:41273.29 stddev:162219.77 (393.0%) stddev-sans-first:162585.01 05:56:28 INFO - PROCESS | 1926 | Values: 467.1 525.5 527.1 536.4 551.8 39740.0 42170.8 42238.4 42327.6 42410.8 42536.8 42988.1 43447.3 43531.6 43741.8 9487.9 9615.6 9649.5 9772.2 9775.0 8303.5 9627.6 9703.5 9712.7 9717.0 9638.9 9714.2 9742.5 9753.2 9762.6 9691.0 9715.2 9734.3 9736.5 9747.3 8480.8 9468.1 9567.4 9676.3 9691.6 41175.2 41203.0 41433.6 41633.4 41674.6 3569.1 3641.0 3660.0 3720.9 3753.5 31835.7 32545.2 33261.2 33454.3 34037.7 3385.2 3387.5 3389.9 3390.2 3504.2 488572.0 491512.0 497942.0 498168.0 498703.0 34174.5 69286.7 69441.7 70102.6 70162.3 37169.3 37375.0 37726.0 37757.2 37810.4 15441.2 15535.5 15656.8 15682.7 15682.8 11293.9 12835.4 12865.2 13074.4 13254.7 7416.1 7599.7 8161.6 8203.5 8226.0 3380.8 3407.1 3417.5 3426.7 3428.4 977.9 1014.8 1019.8 1043.7 1156.8 26417.7 26530.0 30873.0 31304.0 32750.7 960.8 1076.7 1086.9 1102.9 1153.7 14114.1 16416.6 16503.7 16589.9 16666.6 614115.0 699288.0 711625.0 712357.0 713475.0 61628.1 61887.8 62266.7 62279.1 62567.4 1199.8 1411.4 1437.8 1444.6 1448.2 30509.3 30522.7 30559.4 31212.8 31438.5 49474.8 49507.8 49724.8 53149.0 53950.7 604119.0 610790.0 616341.0 617117.0 618847.0 27909.0 27983.7 28885.1 29021.4 29032.1 49484.8 50066.5 50134.7 50247.7 50643.2 33876.3 41078.6 41343.6 42026.5 42113.8 33638.0 36022.3 41457.8 41488.8 41838.8 33800.3 39027.2 39446.8 39598.8 39609.8 35336.5 35918.0 36314.5 36464.6 36577.1 25989.1 26554.0 26566.9 26615.5 26997.0 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | [#2] jquery.html Cycles:180 Average:34765.13 Median:26122.91 stddev:100624.98 (385.2%) stddev-sans-first:100874.15 05:56:28 INFO - PROCESS | 1926 | Values: 386.9 388.4 389.7 394.9 412.4 15000.2 20789.6 21139.4 21698.6 21735.5 20274.2 20887.8 21103.7 21184.0 21606.0 5079.8 5994.9 6046.6 6051.4 6150.6 6028.5 6037.4 6062.5 6153.1 6162.7 5987.0 6103.3 6103.6 6118.1 6133.6 5939.8 5951.6 5956.6 6106.3 6110.7 5290.0 5310.2 5311.7 5315.3 5324.6 25052.4 26107.7 26138.1 26337.6 26352.3 2417.9 2559.6 2754.3 2773.7 3205.6 15415.0 15437.6 15594.2 15943.0 16297.7 1829.0 1845.0 1897.1 1902.5 1929.5 89440.6 113842.4 114040.0 119060.4 123026.0 8861.5 10755.0 11077.6 11159.8 11185.5 13394.5 13538.5 13570.1 13585.0 13664.3 7640.5 8587.8 8620.1 8699.8 8727.7 8662.7 8763.9 8891.3 8944.8 9010.2 6649.0 6702.1 6754.7 6767.4 6791.5 1579.4 1582.2 1838.9 1861.6 1869.6 755.9 935.9 956.4 1008.2 1029.4 20297.8 20744.2 22787.8 22793.0 22853.9 969.1 981.5 986.2 1005.9 1041.8 11497.9 12003.6 12017.4 12022.5 12023.6 592467.0 598689.0 607465.0 620435.0 620724.0 69468.0 96234.0 100797.5 103277.0 107325.0 965.4 988.3 995.3 1002.4 1004.1 14632.0 20048.0 20083.5 20135.4 20138.0 53183.7 53414.7 53951.8 54033.5 55899.7 77623.0 81191.0 82883.3 88936.0 90512.0 7753.6 7822.3 7850.5 7998.7 8183.8 11244.9 11466.9 12517.7 13337.2 13614.1 11496.8 11652.9 11688.6 11737.4 11779.8 10850.7 11491.0 11571.2 11669.4 12022.6 11243.9 11747.4 11755.1 11972.2 12014.8 8130.6 8162.0 8216.5 8298.1 8398.9 11258.5 11331.2 11592.2 11661.8 11818.9 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | [#3] mootools.html Cycles:180 Average:5719.70 Median:5117.18 stddev:3156.88 (61.7%) stddev-sans-first:3150.22 05:56:28 INFO - PROCESS | 1926 | Values: 1555.7 1573.2 1687.5 1769.8 1848.4 7562.8 7862.1 8635.5 9102.5 9115.1 8708.8 8806.9 8888.2 8905.7 8912.3 2073.7 2377.6 2383.6 2404.9 2414.1 2384.6 2387.2 2398.4 2417.3 2433.5 2403.5 2409.5 2411.3 2426.0 2467.3 2363.6 2372.9 2384.5 2396.7 2403.6 2340.9 2356.9 2377.7 2398.6 2408.7 8756.6 8766.9 8864.3 8963.7 9015.0 5201.5 5344.2 5363.0 5409.1 5442.2 3547.7 3690.6 3747.4 3757.9 3771.6 1079.5 1080.6 1080.6 1097.9 1106.0 11513.3 11672.8 11798.7 11821.6 11833.2 4463.4 4557.0 4676.4 4689.3 4695.5 7924.9 9305.4 9328.0 9330.7 9345.8 5219.6 5320.4 5321.6 5325.4 5325.7 4421.8 4762.3 4924.8 4951.5 4990.6 3830.3 3856.2 3916.6 3959.7 3968.7 1189.1 1195.2 1195.3 1204.9 1207.0 777.7 802.7 881.4 911.4 969.7 6120.5 6121.8 6140.5 6203.6 6314.5 898.3 906.1 913.6 936.7 978.6 3915.6 4142.2 4168.7 4185.0 4189.1 8870.5 10410.8 10581.2 10745.0 10821.1 10458.7 10547.9 10704.9 10716.4 10771.3 7919.5 8227.2 8276.0 8288.8 8292.0 5835.2 5933.4 6033.7 6052.9 6056.4 9915.9 9956.0 9981.0 10004.8 10068.7 9631.9 9940.2 10053.9 10159.5 10184.0 6810.8 7407.0 7543.1 7619.0 7630.7 8419.6 8426.5 8465.8 8522.5 8536.7 7427.9 7572.9 7643.5 7696.4 7761.1 7443.5 7448.9 7494.6 7528.8 7580.6 7083.5 7143.8 7172.8 7172.9 7180.7 4449.7 4937.4 5047.5 5082.3 5097.3 5079.1 5107.2 5127.1 5153.1 5154.6 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | [#4] prototype.html Cycles:180 Average:4865.73 Median:5609.73 stddev:1531.10 (27.3%) stddev-sans-first:1496.45 05:56:28 INFO - PROCESS | 1926 | Values: 294.5 314.6 317.5 324.3 324.6 5787.7 5806.7 5825.1 5866.7 5892.9 5735.4 5746.0 5749.8 5788.7 5804.8 3714.1 4178.4 4287.5 4299.2 4300.4 3698.9 4231.2 4271.9 4322.8 4329.9 4146.5 4287.6 4296.2 4306.3 4317.4 3508.8 4081.0 4273.6 4284.0 4294.0 3229.9 3681.4 3709.3 3713.8 3728.2 4121.5 5604.0 5615.5 5636.6 5646.0 4805.2 5015.8 5030.6 5035.4 5048.3 4580.8 4844.5 6015.4 6047.5 6060.9 3119.7 4106.4 4140.3 4176.7 4247.9 5643.7 5755.9 6100.2 6388.9 6435.5 3690.3 4144.3 4158.9 4181.6 4199.8 3846.7 4025.0 4232.4 4259.6 4293.1 4481.9 4751.9 5009.4 5051.9 5061.3 5447.4 5897.1 5977.6 5996.3 6109.8 1298.9 1428.8 1453.8 1454.9 1463.7 831.6 845.4 911.3 925.8 967.0 3997.5 5036.9 5199.6 5257.8 5624.7 6126.8 6225.5 6241.1 6272.9 6277.5 4870.9 5634.6 5661.4 5838.3 5854.3 2969.9 3163.7 3225.0 3298.5 3364.9 5836.7 6075.9 6323.4 6389.0 6484.8 5666.2 5904.8 6103.1 6507.3 6517.5 5748.5 6596.9 6600.9 6607.5 6617.9 5513.0 5527.3 5939.8 6319.9 6354.1 5232.0 5548.6 6219.5 6258.6 6273.7 4997.5 6014.2 6434.5 6513.7 6581.0 3728.0 3930.7 4001.4 4029.3 4032.0 6268.7 6272.7 6284.8 6295.8 6308.2 5264.9 5288.9 5680.4 5770.6 5994.9 5097.8 5171.1 5718.7 5934.5 6120.9 5636.5 5640.3 5922.8 5967.2 5982.4 6026.0 6052.4 6091.9 6100.4 6112.7 5101.7 5509.1 5944.9 6001.2 6004.9 05:56:28 INFO - PROCESS | 1926 | 05:56:28 INFO - PROCESS | 1926 | [#5] yui.html Cycles:180 Average:24727.10 Median:3605.11 stddev:39989.73 (1109.3%) stddev-sans-first:40060.89 05:56:28 INFO - PROCESS | 1926 | Values: 603.3 653.7 787.5 798.2 812.4 14556.3 14582.6 15048.0 15203.3 15988.3 12663.7 13867.1 14684.3 14742.3 14842.6 708.6 760.5 852.6 878.8 895.6 885.1 899.3 900.4 902.3 903.3 923.2 958.8 959.9 963.3 966.3 915.8 917.2 923.2 955.3 956.1 700.0 711.4 712.9 714.4 718.7 15550.2 15917.0 16106.9 16140.8 16143.9 11720.8 13620.9 13621.6 13766.7 13883.7 12613.4 12715.7 13413.6 13683.2 13814.5 4553.7 4578.9 4820.4 4864.8 4866.0 76605.1 111685.4 112594.0 113363.0 113923.0 11095.3 11182.4 11195.7 11200.8 11250.8 21326.5 21332.4 21348.9 21354.6 21416.5 7705.5 7958.2 7966.6 7973.8 8102.0 4041.2 4457.9 4458.0 4481.3 4672.1 3459.4 3555.2 3602.1 3608.2 3608.3 588.0 667.1 673.9 679.1 681.7 641.4 652.4 656.7 673.5 679.6 9357.0 9431.1 9433.0 9681.6 9872.1 670.3 681.7 704.2 706.4 707.2 4481.9 4692.5 4710.9 4712.3 4719.2 142447.3 151317.0 151630.0 152859.0 152923.0 131192.0 132926.0 133179.3 133616.0 136655.0 112202.0 112833.0 112919.0 113345.0 114576.0 8546.1 8961.8 8981.9 9118.2 9208.7 38624.6 53830.0 62527.4 63315.7 64692.0 89200.0 90594.0 92236.0 93258.0 93364.5 11939.6 11963.5 11999.5 12321.5 12388.9 13152.1 13386.2 13394.7 13425.4 13459.4 11375.7 11683.5 12179.4 12397.7 13076.3 12370.7 12652.9 12838.4 12903.5 12923.7 12016.4 12154.5 12393.9 12456.6 12543.9 10541.7 10799.6 10910.1 11021.1 11040.9 9869.8 10541.8 10696.9 10739.4 10748.6 05:56:28 INFO - PROCESS | 1926 | -------- Summary: end -------- 05:56:28 INFO - PROCESS | 1926 | 05:56:29 INFO - TEST-INFO | 1926: exit 0 05:56:29 INFO - TEST-OK | dromaeo_css | took 1114389ms 05:56:29 INFO - TEST-START | kraken 05:56:29 INFO - operating with platform_type : mac_ 05:56:29 INFO - Initialising browser for kraken test... 05:56:29 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpiLWURI/profile http://localhost:49436/getInfo.html) 05:56:32 INFO - PROCESS | 1934 | __metrics Screen width/height:1600/1200 05:56:32 INFO - PROCESS | 1934 | colorDepth:24 05:56:32 INFO - PROCESS | 1934 | Browser inner width/height: 1024/689 05:56:32 INFO - PROCESS | 1934 | __metrics 05:56:32 ERROR - PROCESS | 1934 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 05:56:32 INFO - TEST-INFO | 1934: exit 0 05:56:32 INFO - Browser initialized. 05:56:32 INFO - Running cycle 1/1 for kraken test... 05:56:32 INFO - TEST-INFO | started process 1937 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/T/tmpiLWURI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:56:44 INFO - PROCESS | 1937 | RSS: Main: 255983616 05:56:44 INFO - PROCESS | 1937 | 05:56:47 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-beat-detection) 05:56:48 INFO - PROCESS | 1937 | RSS: Main: 268800000 05:56:48 INFO - PROCESS | 1937 | 05:56:51 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-dft) 05:56:51 INFO - PROCESS | 1937 | RSS: Main: 273321984 05:56:51 INFO - PROCESS | 1937 | 05:56:55 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-fft) 05:56:55 INFO - PROCESS | 1937 | RSS: Main: 273440768 05:56:55 INFO - PROCESS | 1937 | 05:56:58 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-oscillator) 05:56:58 INFO - PROCESS | 1937 | RSS: Main: 274313216 05:56:58 INFO - PROCESS | 1937 | 05:57:00 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:57:01 INFO - PROCESS | 1937 | RSS: Main: 274841600 05:57:01 INFO - PROCESS | 1937 | 05:57:04 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49436/tests/kraken/driver.html?testName=imaging-darkroom) 05:57:04 INFO - PROCESS | 1937 | RSS: Main: 275623936 05:57:04 INFO - PROCESS | 1937 | 05:57:07 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49436/tests/kraken/driver.html?testName=imaging-desaturate) 05:57:08 INFO - PROCESS | 1937 | RSS: Main: 275869696 05:57:08 INFO - PROCESS | 1937 | 05:57:11 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49436/tests/kraken/driver.html?testName=json-parse-financial) 05:57:12 INFO - PROCESS | 1937 | RSS: Main: 276115456 05:57:12 INFO - PROCESS | 1937 | 05:57:13 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:57:14 INFO - PROCESS | 1937 | RSS: Main: 275722240 05:57:14 INFO - PROCESS | 1937 | 05:57:16 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:57:16 INFO - PROCESS | 1937 | RSS: Main: 275177472 05:57:16 INFO - PROCESS | 1937 | 05:57:19 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:57:19 INFO - PROCESS | 1937 | RSS: Main: 275587072 05:57:19 INFO - PROCESS | 1937 | 05:57:22 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:57:23 INFO - PROCESS | 1937 | RSS: Main: 275734528 05:57:23 INFO - PROCESS | 1937 | 05:57:26 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:57:26 INFO - PROCESS | 1937 | RSS: Main: 275587072 05:57:26 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49436/tests/kraken/driver.html?testName=ai-astar) 05:57:28 INFO - PROCESS | 1937 | RSS: Main: 276701184 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | __start_tp_report 05:57:28 INFO - PROCESS | 1937 | _x_x_mozilla_page_load 05:57:28 INFO - PROCESS | 1937 | _x_x_mozilla_page_load_details 05:57:28 INFO - PROCESS | 1937 | |i|pagename|runs| 05:57:28 INFO - PROCESS | 1937 | |0;ai-astar;107;113;110;116;119;117;134;167;123;128 05:57:28 INFO - PROCESS | 1937 | |1;audio-beat-detection;142;108;134;152;110;129;131;109;156;110 05:57:28 INFO - PROCESS | 1937 | |2;audio-dft;199;205;231;245;281;200;188;195;197;200 05:57:28 INFO - PROCESS | 1937 | |3;audio-fft;80;102;109;139;55;59;83;84;163;63 05:57:28 INFO - PROCESS | 1937 | |4;audio-oscillator;68;72;119;94;77;93;117;71;66;117 05:57:28 INFO - PROCESS | 1937 | |5;imaging-gaussian-blur;91;87;88;85;93;115;88;91;115;86 05:57:28 INFO - PROCESS | 1937 | |6;imaging-darkroom;92;94;94;104;150;130;96;94;94;124 05:57:28 INFO - PROCESS | 1937 | |7;imaging-desaturate;89;93;119;138;96;106;146;118;90;111 05:57:28 INFO - PROCESS | 1937 | |8;json-parse-financial;59;57;57;56;56;58;56;58;54;57 05:57:28 INFO - PROCESS | 1937 | |9;json-stringify-tinderbox;68;71;67;76;79;77;74;75;89;72 05:57:28 INFO - PROCESS | 1937 | |10;stanford-crypto-aes;95;101;73;93;74;103;100;104;105;95 05:57:28 INFO - PROCESS | 1937 | |11;stanford-crypto-ccm;159;153;143;137;139;153;158;152;193;155 05:57:28 INFO - PROCESS | 1937 | |12;stanford-crypto-pbkdf2;167;169;165;171;165;167;163;166;165;163 05:57:28 INFO - PROCESS | 1937 | |13;stanford-crypto-sha256-iterative;65;69;66;68;66;68;66;69;64;68 05:57:28 INFO - PROCESS | 1937 | __end_tp_report 05:57:28 INFO - PROCESS | 1937 | __start_cc_report 05:57:28 INFO - PROCESS | 1937 | _x_x_mozilla_cycle_collect,1122 05:57:28 INFO - PROCESS | 1937 | __end_cc_report 05:57:28 INFO - PROCESS | 1937 | __startTimestamp1467809848878__endTimestamp 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | ------- Summary: start ------- 05:57:28 INFO - PROCESS | 1937 | Number of tests: 14 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#0] ai-astar Cycles:10 Average:123.40 Median:121.00 stddev:17.34 (14.3%) stddev-sans-first:17.35 05:57:28 INFO - PROCESS | 1937 | Values: 107.0 113.0 110.0 116.0 119.0 117.0 134.0 167.0 123.0 128.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:132.50 stddev:18.29 (13.8%) stddev-sans-first:18.70 05:57:28 INFO - PROCESS | 1937 | Values: 142.0 108.0 134.0 152.0 110.0 129.0 131.0 109.0 156.0 110.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#2] audio-dft Cycles:10 Average:214.10 Median:202.50 stddev:29.37 (14.5%) stddev-sans-first:30.64 05:57:28 INFO - PROCESS | 1937 | Values: 199.0 205.0 231.0 245.0 281.0 200.0 188.0 195.0 197.0 200.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#3] audio-fft Cycles:10 Average:93.70 Median:61.00 stddev:35.27 (57.8%) stddev-sans-first:37.06 05:57:28 INFO - PROCESS | 1937 | Values: 80.0 102.0 109.0 139.0 55.0 59.0 83.0 84.0 163.0 63.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:71.50 stddev:21.69 (30.3%) stddev-sans-first:21.58 05:57:28 INFO - PROCESS | 1937 | Values: 68.0 72.0 119.0 94.0 77.0 93.0 117.0 71.0 66.0 117.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#5] imaging-gaussian-blur Cycles:10 Average:93.90 Median:88.00 stddev:11.39 (12.9%) stddev-sans-first:12.03 05:57:28 INFO - PROCESS | 1937 | Values: 91.0 87.0 88.0 85.0 93.0 115.0 88.0 91.0 115.0 86.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#6] imaging-darkroom Cycles:10 Average:107.20 Median:94.00 stddev:20.27 (21.6%) stddev-sans-first:20.74 05:57:28 INFO - PROCESS | 1937 | Values: 92.0 94.0 94.0 104.0 150.0 130.0 96.0 94.0 94.0 124.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#7] imaging-desaturate Cycles:10 Average:110.60 Median:117.50 stddev:19.90 (16.9%) stddev-sans-first:19.51 05:57:28 INFO - PROCESS | 1937 | Values: 89.0 93.0 119.0 138.0 96.0 106.0 146.0 118.0 90.0 111.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.40 (2.5%) stddev-sans-first:1.24 05:57:28 INFO - PROCESS | 1937 | Values: 59.0 57.0 57.0 56.0 56.0 58.0 56.0 58.0 54.0 57.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#9] json-stringify-tinderbox Cycles:10 Average:74.80 Median:75.50 stddev:6.29 (8.3%) stddev-sans-first:6.17 05:57:28 INFO - PROCESS | 1937 | Values: 68.0 71.0 67.0 76.0 79.0 77.0 74.0 75.0 89.0 72.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#10] stanford-crypto-aes Cycles:10 Average:94.30 Median:73.50 stddev:11.69 (15.9%) stddev-sans-first:12.40 05:57:28 INFO - PROCESS | 1937 | Values: 95.0 101.0 73.0 93.0 74.0 103.0 100.0 104.0 105.0 95.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:154.00 stddev:15.65 (10.2%) stddev-sans-first:16.50 05:57:28 INFO - PROCESS | 1937 | Values: 159.0 153.0 143.0 137.0 139.0 153.0 158.0 152.0 193.0 155.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.10 Median:166.50 stddev:2.51 (1.5%) stddev-sans-first:2.65 05:57:28 INFO - PROCESS | 1937 | Values: 167.0 169.0 165.0 171.0 165.0 167.0 163.0 166.0 165.0 163.0 05:57:28 INFO - PROCESS | 1937 | 05:57:28 INFO - PROCESS | 1937 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:68.00 stddev:1.73 (2.5%) stddev-sans-first:1.69 05:57:28 INFO - PROCESS | 1937 | Values: 65.0 69.0 66.0 68.0 66.0 68.0 66.0 69.0 64.0 68.0 05:57:28 INFO - PROCESS | 1937 | -------- Summary: end -------- 05:57:28 INFO - PROCESS | 1937 | 05:57:29 INFO - TEST-INFO | 1937: exit 0 05:57:29 INFO - TEST-OK | kraken | took 60466ms 05:57:29 INFO - SUITE-END | took 1174s 05:57:30 INFO - Completed test suite (00:19:35) 05:57:30 INFO - javascript benchmark 05:57:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7459.085937686586, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3039.7872148949573, 3360.680735330143, 3391.4404123319646, 3392.7625066245373, 3404.965950340496, 5104.872378190547, 5501.532369748571, 5770.163326317682, 5846.064629659255, 5846.532277417807, 5638.323401191863, 5845.941540584593, 5900.734466948987, 5915.792947246847, 5965.791197308095, 4256.255155347817, 5196.350456192976, 5213.817516386927, 5229.37247530295, 5358.839234822942, 5336.519713225809, 5336.839894803143, 5365.08793505105, 5378.811741589046, 5408.323959505062, 5182.144946083929, 5212.739363031871, 5253.842384728464, 5291.708956007418, 5307.867303317409, 5283.28675628789, 5286.81496147633, 5286.995470860525, 5310.256564081032, 5329.8934021319355, 5232.6860388376435, 5245.449227831099, 5259.8422047338645, 5282.313299271109, 5331.253624492574, 5669.518090962273, 5760.596758226926, 5771.307443106854, 5855.590108692393, 5869.1196320551835, 4670.976645116787, 4716.198246298138, 5605.775768969236, 6144.8771024579255, 6201.441870231701, 6270.153529273535, 6294.276158241815, 6297.275813281485, 6304.085907543426, 6311.147995020659, 5399.541039011649, 5810.273715785527, 5862.443067908542, 5902.350741418398, 5932.288125424977, 6365.649889256136, 6376.936230637634, 6383.234011918599, 6384.712687928962, 6403.839904002344, 6187.071939209065, 6217.098520714561, 6224.688765561795, 6229.377062293825, 6252.062190671345, 5145.253938178943, 6131.132004888128, 6136.243373036893, 6181.103739957681, 6184.567080304426, 6118.510519158456, 6145.170401995673, 6192.473639740582, 6195.2255968004, 6210.596311239755, 6134.110553969649, 6166.691665416712, 6183.474404675563, 6211.130441738161, 6212.658303793335, 4902.460729319772, 4976.4525902150735, 5008.949910500921, 5033.773480193327, 5034.974825125924, 4461.219286624828, 4466.754328511898, 4489.753063581469, 4489.910201796011, 4500.144972455223, 5922.526197904157, 6006.639601623917, 6021.458068773832, 6022.5784195105925, 6027.095935609694, 5263.289455923478, 6123.038605230386, 6129.23653806838, 6186.907196392058, 6216.720247588869, 5963.522918166536, 5996.130561068708, 6000.8799824004145, 6012.518998480111, 6032.577719559677, 5407.729613519387, 5499.230107784913, 5515.420880807537, 5540.2243685884005, 5554.055810512223, 6355.968220158869, 6399.360063993563, 6427.839304017437, 6499.837504062436, 6543.247526534509, 6282.465990390685, 6304.275008374096, 6315.179026726496, 6316.399942005502, 6318.178636777189, 6224.688765561613, 6358.713857876499, 6481.384268494486, 6498.090267362668, 6503.382178693017, 6124.899720462962, 6164.815055548341, 6214.4407003369915, 6214.8135555933395, 6241.126242325987, 5793.159991801081, 6283.748650053946, 6290.591111577916, 6300.810975670737, 6302.117703521419, 5882.852928676817, 6069.666168360783, 6156.891759483336, 6206.72069756853, 6228.439440450381, 6105.611380716617, 6106.2061931948565, 6107.175531303395, 6134.803982731443, 6160.0, 4727.338172655762, 5380.354357477127, 5850.297964244318, 6120.969395152996, 6159.538034647509, 6098.451139397298, 6105.206323177958, 6143.573288551087, 6193.38066193377, 6198.535109866868, 6114.145302971568, 6122.5506807263955, 6124.667191846973, 6129.00650620687, 6143.174139895698], "value": 5713.457869088684, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.11481742098726, 525.5112745147012, 527.1118165890474, 536.3965538768884, 551.8316913341429, 39739.99999999996, 42170.78914605427, 42238.366424503656, 42327.57672423275, 42410.78794606031, 42536.787316063455, 42988.140237195315, 43447.34828977568, 43531.56468435315, 43741.7812910935, 9487.857682134756, 9615.56729947154, 9649.517524123801, 9772.218222542215, 9774.973627769088, 8303.46027508213, 9627.614895404175, 9703.514824258795, 9712.66005689801, 9717.028297170296, 9638.855417168748, 9714.22286217101, 9742.464164470952, 9753.170980466668, 9762.560684769202, 9690.999999999965, 9715.174210192072, 9734.318597698164, 9736.464494452837, 9747.268954828345, 8480.812686223933, 9468.100530449596, 9567.37812042215, 9676.274279429, 9691.563879625433, 41175.1764964699, 41203.0, 41433.58566414328, 41633.37549936753, 41674.58325416768, 3569.1434055826676, 3640.9635903640888, 3660.0483874192637, 3720.9255814883822, 3753.474513568103, 31835.681643183503, 32545.186370340693, 33261.16847078843, 33454.33091338184, 34037.659623403946, 3385.2044769479153, 3387.5426817379584, 3389.915252118692, 3390.1524618845287, 3504.176518518146, 488572.0, 491512.0, 497942.0, 498168.0, 498702.9999999964, 34174.48738268928, 69286.65356673184, 69441.65279173572, 70102.64948675224, 70162.29837701557, 37169.25661486809, 37375.0, 37726.0, 37757.24485510274, 37810.43284350737, 15441.227938603024, 15535.533933981998, 15656.843431565538, 15682.686346273238, 15682.76475852863, 11293.887061129448, 12835.422405991752, 12865.163764355288, 13074.411651475706, 13254.734905302033, 7416.147143078507, 7599.708049631576, 8161.63272652732, 8203.507789532528, 8226.0, 3380.797152170878, 3407.1311815486893, 3417.5215469834243, 3426.7087297579487, 3428.400029994741, 977.8630991661173, 1014.7868947520956, 1019.7858449725641, 1043.6921108272925, 1156.8380426740264, 26417.735822641913, 26530.0, 30873.0, 31304.0, 32750.67249327524, 960.7598100474881, 1076.6864425400997, 1086.8641419822522, 1102.9338239705644, 1153.7058050197313, 14114.082584631966, 16416.589585260463, 16503.6699266014, 16589.91705041491, 16666.583340415957, 614115.0, 699288.0, 711625.0, 712357.0, 713475.0, 61628.07557886635, 61887.76224475575, 62266.68866655638, 62279.06581401283, 62567.374326257064, 1199.7600479904054, 1411.386047069528, 1437.8130842990554, 1444.6388402899274, 1448.217962300346, 30509.32198729091, 30522.694773051986, 30559.388812224075, 31212.843935780176, 31438.52842207323, 49474.75262623664, 49507.75246123746, 49724.75688107826, 53148.95084966922, 53950.73024634852, 604119.0, 610790.0, 616341.0, 617117.0, 618847.0, 27909.0, 27983.720162798112, 28885.133445996653, 29021.419571608873, 29032.12903612895, 49484.76288092826, 50066.49933500764, 50134.74663133305, 50247.748761255956, 50643.24035139402, 33876.322473550885, 41078.58921410867, 41343.58656413518, 42026.485894686375, 42113.789431052646, 33638.0, 36022.27955440824, 41457.79271103625, 41488.79255603703, 41838.79080604578, 33800.3239935195, 39027.219455611295, 39446.81659550218, 39598.81203563898, 39609.80195099006, 35336.46995295124, 35918.0, 36314.4552831713, 36464.63535364719, 36577.085572860895, 25989.0903818373, 26554.0, 26566.867165664047, 26615.46769064569, 26997.0], "value": 19338.188525996247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.8510623409986, 388.3611459149699, 389.68240883679783, 394.9249642567912, 412.4164307504881, 15000.249987500636, 20789.584208315842, 21139.365819025454, 21698.566028679415, 21735.45661358467, 20274.18903243872, 20887.791122088776, 21103.68344474834, 21184.0, 21606.0, 5079.771410286537, 5994.8801023979495, 6046.576739628228, 6051.425114614105, 6150.600210986271, 6028.4574388305045, 6037.426444487766, 6062.4543791058795, 6153.138560601519, 6162.691865406734, 5987.042073268278, 6103.29812071613, 6103.633781973073, 6118.082287656843, 6133.601315914473, 5939.821805345847, 5951.58338916276, 5956.612820166675, 6106.328303886569, 6110.725017374229, 5290.021346050954, 5310.176922577007, 5311.681299122065, 5315.255864179018, 5324.5740340772645, 25052.373690657696, 26107.738922610723, 26138.085167019064, 26337.604935925978, 26352.341191470176, 2417.9395515112087, 2559.590465525507, 2754.256350785277, 2773.653293338333, 3205.599300087489, 15415.0, 15437.599681020667, 15594.220288985618, 15943.0, 16297.674046519003, 1828.9634207315912, 1844.9558228922251, 1897.1083590712344, 1902.5338791995912, 1929.507975466261, 89440.55279723559, 113842.43078784636, 114040.0, 119060.40469797682, 123026.0, 8861.468311901306, 10755.032047115797, 11077.556897724162, 11159.832602510969, 11185.545879035673, 13394.531191408254, 13538.526151584647, 13570.050096493349, 13585.0, 13664.316784160752, 7640.503367281221, 8587.82824343522, 8620.094890036582, 8699.826003479895, 8727.694530691522, 8662.696805611773, 8763.868541971875, 8891.333150013776, 8944.821103578022, 9010.189082982562, 6648.966755166193, 6702.128723265944, 6754.729810807513, 6767.39093481589, 6791.524593278423, 1579.4156162219822, 1582.2009885007997, 1838.8620853436046, 1861.5625328047897, 1869.5699989002333, 755.8866170074423, 935.9017303183068, 956.3783540698602, 1008.2387797213057, 1029.3669393323203, 20297.782133071767, 20744.170233190503, 22787.772122278566, 22793.0, 22853.857307134578, 969.1277849935115, 981.5092453773113, 986.1716158426956, 1005.9094681478703, 1041.760305236781, 11497.942510287396, 12003.63989080329, 12017.399130043637, 12022.458989345501, 12023.579174728842, 592467.0, 598689.0, 607465.0, 620435.0, 620724.0, 69468.0, 96234.03765962251, 100797.46411411504, 103277.0, 107325.0, 965.3676841668578, 988.2785566536324, 995.3430735714394, 1002.3935519011039, 1004.0762498501397, 14632.0, 20047.997600119645, 20083.497912552302, 20135.39593812188, 20137.99310034522, 53183.73408133089, 53414.73292633512, 53951.795543513, 54033.459665404414, 55899.720501397234, 77623.0, 81191.0, 82883.3423331518, 88936.0, 90512.0, 7753.573553454388, 7822.295993360625, 7850.528968261694, 7998.720044798404, 8183.754487365389, 11244.9437752814, 11466.942665286953, 12517.74964500723, 13337.19976801395, 13614.115082519604, 11496.770064598828, 11652.94173529127, 11688.590899318484, 11737.35444550558, 11779.823302650639, 10850.67447976562, 11491.023263022402, 11571.247868888495, 11669.35818529989, 12022.63932082039, 11243.887561124284, 11747.412629368326, 11755.118366122404, 11972.16194866351, 12014.819777703167, 8130.63412146443, 8161.979752530933, 8216.46592971455, 8298.087210406971, 8398.916010839814, 11258.549658013915, 11331.206815522833, 11592.188546801643, 11661.825072624088, 11818.881811182122], "value": 9869.331942913912, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.7277476441623, 1573.2291177323116, 1687.4768821665277, 1769.7787776527925, 1848.4362269507794, 7562.773116806491, 7862.0958589762195, 8635.481871087739, 9102.499362535058, 9115.08849115089, 8708.825823483543, 8806.86789698155, 8888.244499217575, 8905.688300909469, 8912.287017038638, 2073.699313599535, 2377.583922813509, 2383.5590415773136, 2404.9398765030837, 2414.070582825616, 2384.642303654457, 2387.2002879035545, 2398.436367453647, 2417.3199626259757, 2433.4646377796857, 2403.531311394279, 2409.5301416223842, 2411.2766170148975, 2425.9757402426017, 2467.259822053377, 2363.6218205087275, 2372.893219805113, 2384.546936082139, 2396.7123945126523, 2403.567357875582, 2340.941476463102, 2356.929292121239, 2377.679013333195, 2398.5802484565133, 2408.650745641872, 8756.649734010633, 8766.912330876738, 8864.290856731446, 8963.731088067369, 9014.954925225398, 5201.531862132389, 5344.171653393731, 5363.034653762321, 5409.080456322435, 5442.210879422501, 3547.6984456321243, 3690.5940346561856, 3747.4378843173467, 3757.887263382103, 3771.641694039062, 1079.4872435593109, 1080.5893760371087, 1080.6325849211305, 1097.8627671541058, 1106.0322218059198, 11513.30920144794, 11672.824907626393, 11798.702142764203, 11821.645350639494, 11833.171677982544, 4463.419755431838, 4557.043020965568, 4676.438827340741, 4689.320048592935, 4695.530446955346, 7924.920750792534, 9305.395149315409, 9328.0, 9330.720078397659, 9345.766355841159, 5219.608529360313, 5320.361556613231, 5321.574274058066, 5325.3875804282225, 5325.680459172462, 4421.845235416809, 4762.333273341735, 4924.778384972685, 4951.529604687549, 4990.5508504234795, 3830.272248272819, 3856.2094770571966, 3916.570451785135, 3959.6832253419657, 3968.6626636735623, 1189.120051162134, 1195.1992165249303, 1195.2589394575245, 1204.8915597596083, 1207.0024110097802, 777.7277952716504, 802.7471346525825, 881.4182639457927, 911.3757076402685, 969.7236287658125, 6120.510359171345, 6121.755129794848, 6140.508759299245, 6203.565750397519, 6314.463270621956, 898.3127907151035, 906.1482206725657, 913.6117150211134, 936.6721647423484, 978.617067440784, 3915.6280153385383, 4142.233686767958, 4168.708190426702, 4184.9746812030635, 4189.141226048653, 8870.467771933705, 10410.843837342445, 10581.206409519316, 10745.032947034648, 10821.080208182235, 10458.738531536772, 10547.892471290557, 10704.94647526773, 10716.35701857891, 10771.299865508718, 7919.5248285101925, 8227.218414250636, 8275.95862020686, 8288.792780180424, 8292.0, 5835.183074369506, 5933.3769954154195, 6033.668148251712, 6052.9407353713805, 6056.424639659225, 9915.900840991499, 9956.004399559986, 9980.950095249478, 10004.84992725095, 10068.748281293027, 9631.855522167314, 9940.204783617148, 10053.949730251303, 10159.542820572944, 10184.0, 6810.761623343159, 7406.962965185139, 7543.057117860268, 7619.047619047619, 7630.694772209049, 8419.62111704987, 8426.4944103354, 8465.788355291166, 8522.48865068098, 8536.658533658585, 7427.851442971219, 7572.924270757222, 7643.464957452925, 7696.384289256734, 7761.107472640493, 7443.516171448839, 7448.851022979618, 7494.576030554177, 7528.811779705551, 7580.620968951641, 7083.468739844429, 7143.785686429415, 7172.820679482846, 7172.892406613801, 7180.712771489082, 4449.710768800018, 4937.407511098691, 5047.520485553867, 5082.313887625123, 5097.311862898461, 5079.111155547838, 5107.233914912793, 5127.128388173945, 5153.123968925217, 5154.561862241601], "value": 4608.698162331259, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.512581677324, 314.64445176950045, 317.5142032689984, 324.3027490894578, 324.6396499885129, 5787.726700125976, 5806.693493963856, 5825.126231065342, 5866.677332746697, 5892.852678683035, 5735.369109397973, 5746.0, 5749.786332262078, 5788.739506722197, 5804.796832110877, 3714.108613932657, 4178.435911151986, 4287.48550173978, 4299.183155200518, 4300.440942677447, 3698.94836759673, 4231.217224813419, 4271.914561708764, 4322.84870029549, 4329.870103896872, 4146.543880173179, 4287.614114729674, 4296.248156572603, 4306.289462238727, 4317.352397140438, 3508.8421021054114, 4080.979595102035, 4273.551277115889, 4283.957160428387, 4294.033842385438, 3229.935401291961, 3681.37416639172, 3709.2766910452474, 3713.7771733696063, 3728.229091181694, 4121.52602450719, 5604.0, 5615.455749668874, 5636.605437619368, 5645.971770141123, 4805.198050730976, 5015.84952451427, 5030.622703297231, 5035.395752509722, 5048.343715317022, 4580.816767329303, 4844.5155484451625, 6015.368386319461, 6047.516198704093, 6060.939335616249, 3119.703628155344, 4106.425100485934, 4140.3375459926565, 4176.686748493875, 4247.936280955788, 5643.661380317153, 5755.913661295084, 6100.23747031621, 6388.904166437507, 6435.517336199804, 3690.3357395669036, 4144.274751918402, 4158.896027599274, 4181.60274773896, 4199.832006719758, 3846.7307288489537, 4024.9798751006642, 4232.36514522824, 4259.574042595777, 4293.119910418419, 4481.901934026185, 4751.904961900812, 5009.398872135294, 5051.949480505222, 5061.316722242524, 5447.400785913546, 5897.144913987448, 5977.641341519436, 5996.280446346466, 6109.75560977556, 1298.8960883129328, 1428.8499707530768, 1453.8037364955808, 1454.905431146972, 1463.6926245488567, 831.6091437024588, 845.3913182508584, 911.3392790227165, 925.7778133247972, 966.989495976706, 3997.520297564253, 5036.899262014739, 5199.63602547818, 5257.842264732064, 5624.6625202487985, 6126.754929802758, 6225.470834978987, 6241.127661701471, 6272.937270627326, 6277.515978631903, 4870.8811666925, 5634.6337488063145, 5661.395757951388, 5838.2702162229725, 5854.297484301911, 2969.9109026729234, 3163.7469002479747, 3224.951625725616, 3298.4887342461957, 3364.896939412867, 5836.702263221267, 6075.936711075544, 6323.430891219812, 6388.968055159788, 6484.837879053061, 5666.150077488327, 5904.763809447574, 6103.05402662588, 6507.284198738135, 6517.51118666102, 5748.45389687979, 6596.86806263872, 6600.86798264032, 6607.522179182806, 6617.933820661732, 5513.022967597452, 5527.309086364205, 5939.792107276225, 6319.936800631935, 6354.110424540476, 5232.0, 5548.556115510669, 6219.502439804895, 6258.593191442542, 6273.71768270438, 4997.5002499749735, 6014.218151640259, 6434.522708757068, 6513.7068831903625, 6580.967095164685, 3728.012076799596, 3930.6855451563233, 4001.3997900315185, 4029.3150164472695, 4031.979840100898, 6268.749250029948, 6272.717727702356, 6284.780032698834, 6295.779647712308, 6308.243010838729, 5264.9210261846865, 5288.867778305573, 5680.4319568042865, 5770.6249093808765, 5994.88010239784, 5097.770600323069, 5171.095058364695, 5718.685472299064, 5934.525237980864, 6120.8775824484155, 5636.549076073986, 5640.251522028185, 5922.822315330547, 5967.224260846062, 5982.4316689914385, 6026.0, 6052.364501727431, 6091.939080609137, 6100.352904715791, 6112.694365281807, 5101.724568857786, 5509.118541033416, 5944.910826337522, 6001.159837622824, 6004.909926351195], "value": 4372.184467425737, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.2851071480299, 653.6731634182909, 787.4645241235958, 798.2376830127229, 812.3501199040766, 14556.344964476597, 14582.56252312431, 15048.021878577885, 15203.315850786714, 15988.280527376266, 12663.683407914783, 13867.098638588484, 14684.265786710648, 14742.262886855668, 14842.628934276649, 708.5819366573746, 760.5360729954737, 852.6333676519095, 878.7627340618029, 895.5656506594297, 885.1104639836955, 899.3344924755667, 900.4462255712755, 902.2871931174365, 903.2954295649371, 923.2198792020732, 958.8322043642335, 959.8512230604233, 963.2727290895364, 966.3235734985539, 915.7893684452547, 917.1928702741578, 923.2475532441039, 955.2835373469898, 956.1490273656451, 699.9650017499105, 711.4415184080524, 712.868119397913, 714.4427346669606, 718.7484380466847, 15550.222488875625, 15917.0, 16106.919465402716, 16140.75788863168, 16143.919280403641, 11720.824187637192, 13620.863791362059, 13621.591352259447, 13766.65583360424, 13883.652908677263, 12613.369331533386, 12715.682107947283, 13413.597592072254, 13683.24742139182, 13814.516491922734, 4553.704009239389, 4578.862634120982, 4820.39745031871, 4864.8297309594345, 4865.95134048662, 76605.08487287862, 111685.44157279162, 112594.0, 113363.0, 113923.0, 11095.278806877688, 11182.384968826793, 11195.664130076111, 11200.831987520194, 11250.831237531444, 21326.466838328855, 21332.36002919915, 21348.89325553362, 21354.572908542053, 21416.464588385104, 7705.537667739954, 7958.164392738795, 7966.601669916481, 7973.760787176394, 8101.959490202511, 4041.2321658884716, 4457.888552786141, 4457.955420445819, 4481.282994720894, 4672.088942656217, 3459.41189997701, 3555.235624340779, 3602.063463499509, 3608.1520842601967, 3608.260306637133, 587.9970600146972, 667.1160712056447, 673.8584897171551, 679.0527214535695, 681.7204945972227, 641.4387411015362, 652.4356431686557, 656.6749459017722, 673.4511373230802, 679.6431873266574, 9356.95321523388, 9431.123507330192, 9432.952835235918, 9681.579605098725, 9872.137080246648, 670.3363669966795, 681.6727970574152, 704.2183176673888, 706.4030893894651, 707.1726080485844, 4481.932771008437, 4692.4603670577635, 4710.858674239778, 4712.293156026623, 4719.161569268172, 142447.2877635605, 151317.0, 151630.0, 152859.0, 152923.0, 131192.0, 132926.0, 133179.33410332887, 133616.0, 136655.0, 112202.0, 112832.99999999836, 112919.0, 113345.0, 114576.0, 8546.059933407196, 8961.820763584561, 8981.910180898107, 9118.179363857285, 9208.677696280598, 38624.613753862104, 53830.0, 62527.37472625398, 63315.683421582595, 64692.0, 89200.0, 90594.0, 92236.0, 93258.0, 93364.53317733368, 11939.582114625946, 11963.521459141884, 11999.460024299102, 12321.507139714311, 12388.876111238773, 13152.079354445097, 13386.19682819034, 13394.735005931092, 13425.395857186255, 13459.441969285675, 11375.658730238107, 11683.523019274606, 12179.439437948482, 12397.690057748629, 13076.346182691017, 12370.690732731753, 12652.936735316265, 12838.358082096045, 12903.548375807177, 12923.741525169256, 12016.391887912272, 12154.453049612965, 12393.876061239633, 12456.626301210616, 12543.93728031354, 10541.73645658834, 10799.622013229498, 10910.072643825046, 11021.118310535297, 11040.889591103985, 9869.81562212539, 10541.789164216827, 10696.946515267375, 10739.409332486788, 10748.570057197625], "value": 7837.765197651193, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1573.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 110.0, 116.0, 119.0, 117.0, 134.0, 167.0, 123.0, 128.0], "value": 123.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 134.0, 152.0, 110.0, 129.0, 131.0, 109.0, 156.0, 110.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 205.0, 231.0, 245.0, 281.0, 200.0, 188.0, 195.0, 197.0, 200.0], "value": 214.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 102.0, 109.0, 139.0, 55.0, 59.0, 83.0, 84.0, 163.0, 63.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 72.0, 119.0, 94.0, 77.0, 93.0, 117.0, 71.0, 66.0, 117.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 87.0, 88.0, 85.0, 93.0, 115.0, 88.0, 91.0, 115.0, 86.0], "value": 93.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 94.0, 104.0, 150.0, 130.0, 96.0, 94.0, 94.0, 124.0], "value": 107.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 119.0, 138.0, 96.0, 106.0, 146.0, 118.0, 90.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 57.0, 56.0, 56.0, 58.0, 56.0, 58.0, 54.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 67.0, 76.0, 79.0, 77.0, 74.0, 75.0, 89.0, 72.0], "value": 74.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 101.0, 73.0, 93.0, 74.0, 103.0, 100.0, 104.0, 105.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 153.0, 143.0, 137.0, 139.0, 153.0, 158.0, 152.0, 193.0, 155.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 165.0, 171.0, 165.0, 167.0, 163.0, 166.0, 165.0, 163.0], "value": 166.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 68.0, 66.0, 68.0, 66.0, 69.0, 64.0, 68.0], "value": 66.9, "unit": "score"}]}]} 05:57:30 INFO - Return code: 0 05:57:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:57:30 ERROR - # TBPL SUCCESS # 05:57:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:30 INFO - 2016-07-06 05:57:30.187 screenresolution[1942:12814] starting screenresolution argv=screenresolution get 05:57:30 INFO - 2016-07-06 05:57:30.190 screenresolution[1942:12814] Display 0: 1600x1200x32@60 05:57:30 INFO - 2016-07-06 05:57:30.195 screenresolution[1943:12817] starting screenresolution argv=screenresolution list 05:57:30 INFO - Available Modes on Display 0 05:57:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:30 INFO - Intel Iris: 05:57:30 INFO - Chipset Model: Intel Iris 05:57:30 INFO - Type: GPU 05:57:30 INFO - Bus: Built-In 05:57:30 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:30 INFO - Vendor: Intel (0x8086) 05:57:30 INFO - Device ID: 0x0a2e 05:57:30 INFO - Revision ID: 0x0009 05:57:30 INFO - Displays: 05:57:30 INFO - Display: 05:57:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:30 INFO - Display Serial Number: 1600x1200 60 05:57:30 INFO - Main Display: Yes 05:57:30 INFO - Mirror: Off 05:57:30 INFO - Online: Yes 05:57:30 INFO - Rotation: Supported 05:57:30 INFO - Return code: 0 05:57:30 INFO - Running post-action listener: _resource_record_post_action 05:57:30 INFO - ##### 05:57:30 INFO - ##### Finished run-tests step (success) 05:57:30 INFO - ##### 05:57:30 INFO - Running post-run listener: _resource_record_post_run 05:57:30 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 4009984; Write bytes: 710357504; Read time: 39; Write time: 1966 05:57:30 INFO - TinderboxPrint: CPU usage
54.3% 05:57:30 INFO - TinderboxPrint: I/O read bytes / time
4,009,984 / 39 05:57:30 INFO - TinderboxPrint: I/O write bytes / time
710,357,504 / 1,966 05:57:30 INFO - TinderboxPrint: CPU idle
2,212.5 (45.7%) 05:57:30 INFO - TinderboxPrint: CPU system
978.6 (20.2%) 05:57:30 INFO - TinderboxPrint: CPU user
1,650.5 (34.1%) 05:57:30 INFO - TinderboxPrint: Swap in / out
412,086,272 / 0 05:57:30 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 398430720; Write bytes: 392324608; Read time: 29434; Write time: 704 05:57:30 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 3166208; Write bytes: 300231680; Read time: 35; Write time: 1220 05:57:30 INFO - Running post-run listener: _upload_blobber_files 05:57:30 INFO - Blob upload gear active. 05:57:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:57:30 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 05:57:30 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'] 05:57:30 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 05:57:31 INFO - (blobuploader) - INFO - Open directory for files ... 05:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:57:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:32 INFO - (blobuploader) - INFO - Done attempting. 05:57:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:57:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:57:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:33 INFO - (blobuploader) - INFO - Done attempting. 05:57:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:57:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:57:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:57:35 INFO - (blobuploader) - INFO - Done attempting. 05:57:35 INFO - (blobuploader) - INFO - Iteration through files over. 05:57:35 INFO - Return code: 0 05:57:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:57:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:57:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e4be1e987ebdbeb363d178d6941aa94d3318f99911d49a36f74bac7da3d70ac43377a2755f3a2117bf9acd1313d242a8cc94a33f0438e9178f3871a808a99d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb46454e634b6f961c3430d4f0525f762e4ecba39c5d3e074b83876935fc5c927741070c67e9f1ef222686e243827dcb4e67479a48323c961e5cefb5aa0b38dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03e588040ac983dd0129673d5fed98f9376b06211e1ef8668abb5b5ebf16ed68ba1c007a7d2f1f91306cc52cafe2f279e727b20aeaa4a457db1dd152c20b78c4"} 05:57:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:57:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:57:35 INFO - Contents: 05:57:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5e4be1e987ebdbeb363d178d6941aa94d3318f99911d49a36f74bac7da3d70ac43377a2755f3a2117bf9acd1313d242a8cc94a33f0438e9178f3871a808a99d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb46454e634b6f961c3430d4f0525f762e4ecba39c5d3e074b83876935fc5c927741070c67e9f1ef222686e243827dcb4e67479a48323c961e5cefb5aa0b38dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03e588040ac983dd0129673d5fed98f9376b06211e1ef8668abb5b5ebf16ed68ba1c007a7d2f1f91306cc52cafe2f279e727b20aeaa4a457db1dd152c20b78c4"} 05:57:35 INFO - Running post-run listener: copy_logs_to_upload_dir 05:57:35 INFO - Copying logs to upload dir... 05:57:35 INFO - mkdir: /builds/slave/test/build/upload/logs 05:57:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.813446 ========= master_lag: 2.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2016-07-06 05:57:38.040890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 05:57:38.048069) ========= 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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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/d5e4be1e987ebdbeb363d178d6941aa94d3318f99911d49a36f74bac7da3d70ac43377a2755f3a2117bf9acd1313d242a8cc94a33f0438e9178f3871a808a99d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb46454e634b6f961c3430d4f0525f762e4ecba39c5d3e074b83876935fc5c927741070c67e9f1ef222686e243827dcb4e67479a48323c961e5cefb5aa0b38dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03e588040ac983dd0129673d5fed98f9376b06211e1ef8668abb5b5ebf16ed68ba1c007a7d2f1f91306cc52cafe2f279e727b20aeaa4a457db1dd152c20b78c4"} build_url:https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011148 build_url: 'https://queue.taskcluster.net/v1/task/MDlKT1VESPubPRYuiHyTGA/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/d5e4be1e987ebdbeb363d178d6941aa94d3318f99911d49a36f74bac7da3d70ac43377a2755f3a2117bf9acd1313d242a8cc94a33f0438e9178f3871a808a99d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eb46454e634b6f961c3430d4f0525f762e4ecba39c5d3e074b83876935fc5c927741070c67e9f1ef222686e243827dcb4e67479a48323c961e5cefb5aa0b38dd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/03e588040ac983dd0129673d5fed98f9376b06211e1ef8668abb5b5ebf16ed68ba1c007a7d2f1f91306cc52cafe2f279e727b20aeaa4a457db1dd152c20b78c4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 05:57:38.082632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 05:57:38.085981) ========= 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.Ntt1GMpCQ4/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.EAOCZcqG20/Listeners TMPDIR=/var/folders/r2/7_qh7wy12sb77w8gdmz8z9zr00000w/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.005311 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 05:57:38.134334) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 05:57:38.134635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 05:57:38.137982) ========= ========= Total master_lag: 2.94 =========