builder: autoland_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0388 starttime: 1468449032.91 results: success (0) buildid: 20160713131643 builduid: 4c475231baba472e9b4a877109b8bd5d revision: bb5d09eec5eee960351a3a87aa30bbe87c25298d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:32.913677) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:32.914124) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:32.914401) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:32.942051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:32.942691) ========= 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.s139zN1pHh/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.uDJusuSp7k/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-13 15:30:32-- 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% 10.6M=0.001s 2016-07-13 15:30:33 (10.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.086663 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:33.053019) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:33.053351) ========= 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.s139zN1pHh/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.uDJusuSp7k/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.025276 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:33.204465) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 15:30:33.204834) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bb5d09eec5eee960351a3a87aa30bbe87c25298d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev bb5d09eec5eee960351a3a87aa30bbe87c25298d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s139zN1pHh/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.uDJusuSp7k/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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-13 15:30:33,285 truncating revision to first 12 chars 2016-07-13 15:30:33,285 Setting DEBUG logging. 2016-07-13 15:30:33,285 attempt 1/10 2016-07-13 15:30:33,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bb5d09eec5ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 15:30:34,383 unpacking tar archive at: autoland-bb5d09eec5ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377973 ========= master_lag: 0.24 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-13 15:30:34.820374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:34.820702) ========= script_repo_revision: bb5d09eec5eee960351a3a87aa30bbe87c25298d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:34.821124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:34.821392) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 15:30:35.771298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-13 15:30:35.771692) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.s139zN1pHh/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.uDJusuSp7k/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:30:35 INFO - MultiFileLogger online at 20160713 15:30:35 in /builds/slave/test 15:30:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 15:30:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:30:35 INFO - {'append_to_log': False, 15:30:35 INFO - 'base_work_dir': '/builds/slave/test', 15:30:35 INFO - 'blob_upload_branch': 'Autoland', 15:30:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:30:35 INFO - 'branch': 'Autoland', 15:30:35 INFO - 'buildbot_json_path': 'buildprops.json', 15:30:35 INFO - 'config_files': ('talos/mac_config.py',), 15:30:35 INFO - 'default_actions': ('clobber', 15:30:35 INFO - 'read-buildbot-config', 15:30:35 INFO - 'download-and-extract', 15:30:35 INFO - 'populate-webroot', 15:30:35 INFO - 'create-virtualenv', 15:30:35 INFO - 'install', 15:30:35 INFO - 'run-tests'), 15:30:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:30:35 INFO - 'download_minidump_stackwalk': True, 15:30:35 INFO - 'download_symbols': 'ondemand', 15:30:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:30:35 INFO - 'tooltool.py': '/tools/tooltool.py', 15:30:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:30:35 INFO - '/tools/misc-python/virtualenv.py')}, 15:30:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:30:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:30:35 INFO - 'installer_path': 'installer.exe', 15:30:35 INFO - 'log_level': 'info', 15:30:35 INFO - 'log_name': 'talos', 15:30:35 INFO - 'log_to_console': True, 15:30:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:30:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:30:35 INFO - 'opt_config_files': (), 15:30:35 INFO - 'pip_index': False, 15:30:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:35 INFO - 'cmd': ('bash', 15:30:35 INFO - '-c', 15:30:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:35 INFO - 'enabled': True, 15:30:35 INFO - 'halt_on_failure': False, 15:30:35 INFO - 'name': 'check_screen_resolution'},), 15:30:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:30:35 INFO - 'cmd': ('bash', 15:30:35 INFO - '-c', 15:30:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:30:35 INFO - 'enabled': True, 15:30:35 INFO - 'halt_on_failure': False, 15:30:35 INFO - 'name': 'check_screen_resolution'},), 15:30:35 INFO - 'run_cmd_checks_enabled': True, 15:30:35 INFO - 'sps_profile': False, 15:30:35 INFO - 'sps_profile_interval': 0, 15:30:35 INFO - 'suite': 'dromaeojs-e10s', 15:30:35 INFO - 'system_bits': '32', 15:30:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:30:35 INFO - 'title': 't-yosemite-r7-0388', 15:30:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:30:35 INFO - 'use_talos_json': True, 15:30:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:30:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:30:35 INFO - 'work_dir': 'build'} 15:30:35 INFO - ##### 15:30:35 INFO - ##### Running clobber step. 15:30:35 INFO - ##### 15:30:35 INFO - Running pre-action listener: _resource_record_pre_action 15:30:35 INFO - Running main action method: clobber 15:30:35 INFO - rmtree: /builds/slave/test/build 15:30:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:30:37 INFO - Running post-action listener: _resource_record_post_action 15:30:37 INFO - ##### 15:30:37 INFO - ##### Finished clobber step (success) 15:30:37 INFO - ##### 15:30:37 INFO - ##### 15:30:37 INFO - ##### Running read-buildbot-config step. 15:30:37 INFO - ##### 15:30:37 INFO - Running pre-action listener: _resource_record_pre_action 15:30:37 INFO - Running main action method: read_buildbot_config 15:30:37 INFO - Using buildbot properties: 15:30:37 INFO - { 15:30:37 INFO - "project": "", 15:30:37 INFO - "product": "firefox", 15:30:37 INFO - "script_repo_revision": "production", 15:30:37 INFO - "builddir": "autoland_yosemite_r7_test-dromaeojs-e10s", 15:30:37 INFO - "repository": "", 15:30:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 autoland talos dromaeojs-e10s", 15:30:37 INFO - "buildid": "20160713131643", 15:30:37 INFO - "pgo_build": "False", 15:30:37 INFO - "basedir": "/builds/slave/test", 15:30:37 INFO - "buildnumber": 17, 15:30:37 INFO - "slavename": "t-yosemite-r7-0388", 15:30:37 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 15:30:37 INFO - "platform": "yosemite_r7", 15:30:37 INFO - "scheduler": "tests-autoland-macosx64-talos", 15:30:37 INFO - "branch": "autoland", 15:30:37 INFO - "repo_path": "integration/autoland", 15:30:37 INFO - "revision": "bb5d09eec5eee960351a3a87aa30bbe87c25298d", 15:30:37 INFO - "stage_platform": "macosx64", 15:30:37 INFO - "builduid": "4c475231baba472e9b4a877109b8bd5d", 15:30:37 INFO - "slavebuilddir": "test" 15:30:37 INFO - } 15:30:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 15:30:37 INFO - Running post-action listener: _resource_record_post_action 15:30:37 INFO - ##### 15:30:37 INFO - ##### Finished read-buildbot-config step (success) 15:30:37 INFO - ##### 15:30:37 INFO - ##### 15:30:37 INFO - ##### Running download-and-extract step. 15:30:37 INFO - ##### 15:30:37 INFO - Running pre-action listener: _resource_record_pre_action 15:30:37 INFO - Running main action method: download_and_extract 15:30:37 INFO - mkdir: /builds/slave/test/build/tests 15:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:37 INFO - https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 15:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 15:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:38 INFO - Downloaded 1199 bytes. 15:30:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 15:30:38 INFO - Using the following test package requirements: 15:30:38 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 15:30:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 15:30:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 15:30:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'jsshell-mac.zip'], 15:30:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 15:30:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 15:30:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 15:30:38 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 15:30:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 15:30:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 15:30:38 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 15:30:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:30:38 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')]} 15:30:38 INFO - https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:30:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:30:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:30:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:40 INFO - Downloaded 18822892 bytes. 15:30:40 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'] 15:30:40 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 15:30:43 INFO - Return code: 0 15:30:43 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 15:30: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')]} 15:30:43 INFO - https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:30:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:30:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 15:30:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:45 INFO - Downloaded 18822892 bytes. 15:30:45 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'] 15:30:45 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 15:30:48 INFO - Return code: 0 15:30:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:48 INFO - https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:30:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:30:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 15:30:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:49 INFO - Downloaded 14403317 bytes. 15:30:49 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'] 15:30:49 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 15:30:49 INFO - Return code: 0 15:30:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:49 INFO - https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 15:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AP3KEPuzT26gqxI-1gLeNw/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 15:30:52 INFO - Downloaded 112791610 bytes. 15:30:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:30:52 INFO - mkdir: /builds/slave/test/properties 15:30:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:30:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:30:52 INFO - Contents: 15:30:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 15:30:54 INFO - Running post-action listener: _resource_record_post_action 15:30:54 INFO - Running post-action listener: set_extra_try_arguments 15:30:54 INFO - ##### 15:30:54 INFO - ##### Finished download-and-extract step (success) 15:30:54 INFO - ##### 15:30:54 INFO - ##### 15:30:54 INFO - ##### Running populate-webroot step. 15:30:54 INFO - ##### 15:30:54 INFO - Running pre-action listener: _resource_record_pre_action 15:30:54 INFO - Running main action method: populate_webroot 15:30:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:30:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:30:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:30:54 INFO - '--tppagecycles', 15:30:54 INFO - '7'], 15:30:54 INFO - 'tests': ['tsvgm']}}, 15:30:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:30:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:30:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:30:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:30:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:30:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['damp', 'tps']}, 15:30:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'tests': ['damp', 'tps']}, 15:30:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['dromaeo_dom']}, 15:30:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:30:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['basic_compositor_video']}, 15:30:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:30:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'other-e10s': {'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['a11yr', 15:30:54 INFO - 'ts_paint', 15:30:54 INFO - 'tpaint', 15:30:54 INFO - 'sessionrestore', 15:30:54 INFO - 'sessionrestore_no_auto_restore', 15:30:54 INFO - 'tabpaint']}, 15:30:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['tsvgx', 15:30:54 INFO - 'tsvgr_opacity', 15:30:54 INFO - 'tart', 15:30:54 INFO - 'tscrollx', 15:30:54 INFO - 'cart']}, 15:30:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:30:54 INFO - 'tsvgr_opacity', 15:30:54 INFO - 'tart', 15:30:54 INFO - 'tscrollx', 15:30:54 INFO - 'cart']}, 15:30:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-e10s'], 15:30:54 INFO - 'tests': ['tp5o']}, 15:30:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'tests': ['tp5o']}, 15:30:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'talos_options': ['--disable-e10s', 15:30:54 INFO - '--xperf_path', 15:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:54 INFO - 'tests': ['tp5n']}, 15:30:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:30:54 INFO - 'talos_options': ['--xperf_path', 15:30:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:30:54 INFO - 'tests': ['tp5n']}}, 15:30:54 INFO - 'talos.zip': {'path': '', 15:30:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:30:54 INFO - Running post-action listener: _resource_record_post_action 15:30:54 INFO - ##### 15:30:54 INFO - ##### Finished populate-webroot step (success) 15:30:54 INFO - ##### 15:30:54 INFO - ##### 15:30:54 INFO - ##### Running create-virtualenv step. 15:30:54 INFO - ##### 15:30:54 INFO - Running pre-action listener: _resource_record_pre_action 15:30:54 INFO - Running main action method: create_virtualenv 15:30:54 INFO - Creating virtualenv /builds/slave/test/build/venv 15:30:54 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 15:30:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:30:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:30:54 INFO - Using real prefix '/tools/python27' 15:30:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:30:54 INFO - Installing distribute.............................................................................................................................................................................................done. 15:30:57 INFO - Installing pip.................done. 15:30:57 INFO - Return code: 0 15:30:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30:57 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:30:57 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 15:30:57 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 15:30:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:30:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:30:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:30:57 INFO - 'HOME': '/Users/cltbld', 15:30:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:30:57 INFO - 'LOGNAME': 'cltbld', 15:30:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:57 INFO - 'MOZ_NO_REMOTE': '1', 15:30:57 INFO - 'NO_EM_RESTART': '1', 15:30:57 INFO - 'PAGER': '/bin/cat', 15:30:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:30:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:57 INFO - 'PWD': '/builds/slave/test', 15:30:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:30:57 INFO - 'SHELL': '/bin/bash', 15:30:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:30:57 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:30:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:30:57 INFO - 'USER': 'cltbld', 15:30:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:30:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:30:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:57 INFO - 'XPC_FLAGS': '0x0', 15:30:57 INFO - 'XPC_SERVICE_NAME': '0', 15:30:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:30:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:57 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 15:30:57 INFO - Cleaning up... 15:30:57 INFO - Return code: 0 15:30:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:30:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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')]} 15:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:30: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', '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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:30: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:30: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 psutil>=3.1.1 15:30:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:30:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:30:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:30:58 INFO - 'HOME': '/Users/cltbld', 15:30:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:30:58 INFO - 'LOGNAME': 'cltbld', 15:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:30:58 INFO - 'MOZ_NO_REMOTE': '1', 15:30:58 INFO - 'NO_EM_RESTART': '1', 15:30:58 INFO - 'PAGER': '/bin/cat', 15:30:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:30:58 INFO - 'PWD': '/builds/slave/test', 15:30:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:30:58 INFO - 'SHELL': '/bin/bash', 15:30:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:30:58 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:30:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:30:58 INFO - 'USER': 'cltbld', 15:30:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:30:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:30:58 INFO - 'XPC_FLAGS': '0x0', 15:30:58 INFO - 'XPC_SERVICE_NAME': '0', 15:30:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:30:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:30:58 INFO - Downloading/unpacking psutil>=3.1.1 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:30: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 15:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:01 INFO - Installing collected packages: psutil 15:31:01 INFO - Running setup.py install for psutil 15:31:01 INFO - building 'psutil._psutil_osx' extension 15:31:01 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 15:31:01 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 15:31:01 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 15:31:01 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 15:31:02 INFO - building 'psutil._psutil_posix' extension 15:31:02 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 15:31:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:31:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:31:02 INFO - ^ 15:31:02 INFO - 1 warning generated. 15:31:02 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 15:31:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:02 INFO - Successfully installed psutil 15:31:02 INFO - Cleaning up... 15:31:02 INFO - Return code: 0 15:31:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31:02 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')]} 15:31:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:02 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')]} 15:31:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:02 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:02 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 15:31:02 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 15:31:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:02 INFO - 'HOME': '/Users/cltbld', 15:31:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:02 INFO - 'LOGNAME': 'cltbld', 15:31:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:02 INFO - 'MOZ_NO_REMOTE': '1', 15:31:02 INFO - 'NO_EM_RESTART': '1', 15:31:02 INFO - 'PAGER': '/bin/cat', 15:31:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:02 INFO - 'PWD': '/builds/slave/test', 15:31:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:02 INFO - 'SHELL': '/bin/bash', 15:31:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:02 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:02 INFO - 'USER': 'cltbld', 15:31:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:02 INFO - 'XPC_FLAGS': '0x0', 15:31:02 INFO - 'XPC_SERVICE_NAME': '0', 15:31:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:02 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 15:31:02 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 15:31:02 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 15:31:02 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 15:31:02 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 15:31:02 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 15:31:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:05 INFO - Installing collected packages: mozsystemmonitor 15:31:05 INFO - Running setup.py install for mozsystemmonitor 15:31:05 INFO - Successfully installed mozsystemmonitor 15:31:05 INFO - Cleaning up... 15:31:05 INFO - Return code: 0 15:31:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:31:05 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')]} 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:05 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')]} 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:05 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:05 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 15:31:05 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 15:31:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:05 INFO - 'HOME': '/Users/cltbld', 15:31:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:05 INFO - 'LOGNAME': 'cltbld', 15:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:05 INFO - 'MOZ_NO_REMOTE': '1', 15:31:05 INFO - 'NO_EM_RESTART': '1', 15:31:05 INFO - 'PAGER': '/bin/cat', 15:31:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:05 INFO - 'PWD': '/builds/slave/test', 15:31:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:05 INFO - 'SHELL': '/bin/bash', 15:31:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:05 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:05 INFO - 'USER': 'cltbld', 15:31:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:05 INFO - 'XPC_FLAGS': '0x0', 15:31:05 INFO - 'XPC_SERVICE_NAME': '0', 15:31:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:05 INFO - Downloading/unpacking jsonschema==2.5.1 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:08 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:08 INFO - warning: no files found matching '*.txt' 15:31:08 INFO - no previously-included directories found matching 'build' 15:31:08 INFO - no previously-included directories found matching 'dist' 15:31:08 INFO - no previously-included directories found matching '.git*' 15:31:08 INFO - Installing collected packages: jsonschema, functools32 15:31:08 INFO - Running setup.py install for functools32 15:31:08 INFO - warning: no files found matching '*.txt' 15:31:08 INFO - no previously-included directories found matching 'build' 15:31:08 INFO - no previously-included directories found matching 'dist' 15:31:08 INFO - no previously-included directories found matching '.git*' 15:31:08 INFO - Successfully installed jsonschema functools32 15:31:08 INFO - Cleaning up... 15:31:09 INFO - Return code: 0 15:31:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31: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')]} 15:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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')]} 15:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:09 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:09 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 15:31:09 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 15:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:09 INFO - 'HOME': '/Users/cltbld', 15:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:09 INFO - 'LOGNAME': 'cltbld', 15:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:09 INFO - 'MOZ_NO_REMOTE': '1', 15:31:09 INFO - 'NO_EM_RESTART': '1', 15:31:09 INFO - 'PAGER': '/bin/cat', 15:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:09 INFO - 'PWD': '/builds/slave/test', 15:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:09 INFO - 'SHELL': '/bin/bash', 15:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:09 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:09 INFO - 'USER': 'cltbld', 15:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:09 INFO - 'XPC_FLAGS': '0x0', 15:31:09 INFO - 'XPC_SERVICE_NAME': '0', 15:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:09 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:11 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 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 15:31:11 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 15:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:12 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 15:31:12 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 15:31:12 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 15:31:12 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 15:31:12 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 15:31:12 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 15:31:12 INFO - Downloading docopt-0.6.1.tar.gz 15:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:13 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:13 INFO - Running setup.py install for blobuploader 15:31:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:13 INFO - Running setup.py install for requests 15:31:13 INFO - Running setup.py install for docopt 15:31:13 INFO - Successfully installed blobuploader requests docopt 15:31:13 INFO - Cleaning up... 15:31:13 INFO - Return code: 0 15:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:13 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')]} 15:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:13 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')]} 15:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:13 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:13 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 15:31:13 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 15:31:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:13 INFO - 'HOME': '/Users/cltbld', 15:31:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:13 INFO - 'LOGNAME': 'cltbld', 15:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:13 INFO - 'MOZ_NO_REMOTE': '1', 15:31:13 INFO - 'NO_EM_RESTART': '1', 15:31:13 INFO - 'PAGER': '/bin/cat', 15:31:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:13 INFO - 'PWD': '/builds/slave/test', 15:31:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:13 INFO - 'SHELL': '/bin/bash', 15:31:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:13 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:13 INFO - 'USER': 'cltbld', 15:31:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:13 INFO - 'XPC_FLAGS': '0x0', 15:31:13 INFO - 'XPC_SERVICE_NAME': '0', 15:31:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Cexzbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-qC0V9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-vBNY5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-cV7h75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-agkViV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ISnuYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-PUrK34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:14 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-gUtW5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-bP2gov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-llYIWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-sdGU7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-g6CYm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-PutTJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-AXevZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-zT5CaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-MLis3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:15 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-NXDaEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:15 INFO - Running setup.py install for manifestparser 15:31:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozcrash 15:31:16 INFO - Running setup.py install for mozdebug 15:31:16 INFO - Running setup.py install for mozdevice 15:31:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozfile 15:31:16 INFO - Running setup.py install for mozhttpd 15:31:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozinfo 15:31:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:16 INFO - Running setup.py install for mozInstall 15:31:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Running setup.py install for mozleak 15:31:17 INFO - Running setup.py install for mozlog 15:31:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Running setup.py install for moznetwork 15:31:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Running setup.py install for mozprocess 15:31:17 INFO - Running setup.py install for mozprofile 15:31:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:17 INFO - Running setup.py install for mozrunner 15:31:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:18 INFO - Running setup.py install for mozscreenshot 15:31:18 INFO - Running setup.py install for moztest 15:31:18 INFO - Running setup.py install for mozversion 15:31:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:18 INFO - Cleaning up... 15:31:18 INFO - Return code: 0 15:31:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:31:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:18 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:18 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 15:31:18 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 15:31:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:18 INFO - 'HOME': '/Users/cltbld', 15:31:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:18 INFO - 'LOGNAME': 'cltbld', 15:31:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:18 INFO - 'MOZ_NO_REMOTE': '1', 15:31:18 INFO - 'NO_EM_RESTART': '1', 15:31:18 INFO - 'PAGER': '/bin/cat', 15:31:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:18 INFO - 'PWD': '/builds/slave/test', 15:31:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:18 INFO - 'SHELL': '/bin/bash', 15:31:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:18 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:18 INFO - 'USER': 'cltbld', 15:31:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:18 INFO - 'XPC_FLAGS': '0x0', 15:31:18 INFO - 'XPC_SERVICE_NAME': '0', 15:31:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:18 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ZUMAtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:18 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-8KnzDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:18 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)) 15:31:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:18 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-U9cfbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-81lysG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-BGPH7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-cFUY41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-GuP3C4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-0yGmqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-EghrrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-jwPBpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-9Xrw2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:19 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)) 15:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:19 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Y5qUKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Pzj7lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:20 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)) 15:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-P3nTKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-ULMB6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:20 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)) 15:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-Pb4wwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:20 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)) 15:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:20 INFO - Running setup.py (path:/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/pip-sNtZQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:20 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)) 15:31:20 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)) 15:31:20 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)) 15:31:20 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)) 15:31:20 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)) 15:31:20 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)) 15:31:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:20 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 15:31:20 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 15:31:20 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 15:31:20 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 15:31:20 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 15:31:20 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 15:31:22 INFO - Downloading blessings-1.6.tar.gz 15:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:23 INFO - Installing collected packages: blessings 15:31:23 INFO - Running setup.py install for blessings 15:31:23 INFO - Successfully installed blessings 15:31:23 INFO - Cleaning up... 15:31:23 INFO - Return code: 0 15:31:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:23 INFO - Reading from file tmpfile_stdout 15:31:23 INFO - Current package versions: 15:31:23 INFO - blessings == 1.6 15:31:23 INFO - blobuploader == 1.2.4 15:31:23 INFO - docopt == 0.6.1 15:31:23 INFO - functools32 == 3.2.3-2 15:31:23 INFO - jsonschema == 2.5.1 15:31:23 INFO - manifestparser == 1.1 15:31:23 INFO - mozInstall == 1.12 15:31:23 INFO - mozcrash == 0.17 15:31:23 INFO - mozdebug == 0.1 15:31:23 INFO - mozdevice == 0.48 15:31:23 INFO - mozfile == 1.2 15:31:23 INFO - mozhttpd == 0.7 15:31:23 INFO - mozinfo == 0.9 15:31:23 INFO - mozleak == 0.1 15:31:23 INFO - mozlog == 3.2 15:31:23 INFO - moznetwork == 0.27 15:31:23 INFO - mozprocess == 0.23 15:31:23 INFO - mozprofile == 0.28 15:31:23 INFO - mozrunner == 6.12 15:31:23 INFO - mozscreenshot == 0.1 15:31:23 INFO - mozsystemmonitor == 0.3 15:31:23 INFO - moztest == 0.7 15:31:23 INFO - mozversion == 1.4 15:31:23 INFO - psutil == 3.1.1 15:31:23 INFO - requests == 1.2.3 15:31:23 INFO - wsgiref == 0.1.2 15:31:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:23 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')]} 15:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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')]} 15:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:23 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 15:31:23 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 15:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:23 INFO - 'HOME': '/Users/cltbld', 15:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:23 INFO - 'LOGNAME': 'cltbld', 15:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:23 INFO - 'MOZ_NO_REMOTE': '1', 15:31:23 INFO - 'NO_EM_RESTART': '1', 15:31:23 INFO - 'PAGER': '/bin/cat', 15:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:23 INFO - 'PWD': '/builds/slave/test', 15:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:23 INFO - 'SHELL': '/bin/bash', 15:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:23 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:23 INFO - 'USER': 'cltbld', 15:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:23 INFO - 'XPC_FLAGS': '0x0', 15:31:23 INFO - 'XPC_SERVICE_NAME': '0', 15:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 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)) 15:31:23 INFO - Cleaning up... 15:31:23 INFO - Return code: 0 15:31:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:23 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')]} 15:31:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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')]} 15:31:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:23 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 0x109fa0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a035618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc169d60040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, '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.s139zN1pHh/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.uDJusuSp7k/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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 15:31:23 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 15:31:23 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 15:31:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:23 INFO - 'HOME': '/Users/cltbld', 15:31:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:23 INFO - 'LOGNAME': 'cltbld', 15:31:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:23 INFO - 'MOZ_NO_REMOTE': '1', 15:31:23 INFO - 'NO_EM_RESTART': '1', 15:31:23 INFO - 'PAGER': '/bin/cat', 15:31:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:23 INFO - 'PWD': '/builds/slave/test', 15:31:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:23 INFO - 'SHELL': '/bin/bash', 15:31:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:23 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:23 INFO - 'USER': 'cltbld', 15:31:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:23 INFO - 'XPC_FLAGS': '0x0', 15:31:23 INFO - 'XPC_SERVICE_NAME': '0', 15:31:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:24 INFO - Cleaning up... 15:31:24 INFO - Return code: 0 15:31:24 INFO - Running post-action listener: _resource_record_post_action 15:31:24 INFO - Running post-action listener: _start_resource_monitoring 15:31:24 INFO - Starting resource monitoring. 15:31:24 INFO - ##### 15:31:24 INFO - ##### Finished create-virtualenv step (success) 15:31:24 INFO - ##### 15:31:24 INFO - ##### 15:31:24 INFO - ##### Running install step. 15:31:24 INFO - ##### 15:31:24 INFO - Running pre-action listener: _resource_record_pre_action 15:31:24 INFO - Running main action method: install 15:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:24 INFO - Reading from file tmpfile_stdout 15:31:24 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:24 INFO - Reading from file tmpfile_stdout 15:31:24 INFO - Output received: 15:31:24 INFO - Usage: mozinstall [options] installer 15:31:24 INFO - Options: 15:31:24 INFO - -h, --help show this help message and exit 15:31:24 INFO - -d DEST, --destination=DEST 15:31:24 INFO - Directory to install application into. [default: 15:31:24 INFO - "/builds/slave/test"] 15:31:24 INFO - --app=APP Application being installed. [default: firefox] 15:31:24 INFO - mkdir: /builds/slave/test/build/application 15:31:24 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'] 15:31:24 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 15:31:59 INFO - Reading from file tmpfile_stdout 15:31:59 INFO - Output received: 15:31:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:31:59 INFO - Running post-action listener: _resource_record_post_action 15:31:59 INFO - ##### 15:31:59 INFO - ##### Finished install step (success) 15:31:59 INFO - ##### 15:31:59 INFO - ##### 15:31:59 INFO - ##### Running run-tests step. 15:31:59 INFO - ##### 15:31:59 INFO - Running pre-action listener: _resource_record_pre_action 15:31:59 INFO - Running main action method: run_tests 15:31:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:31:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:31:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:31:59 INFO - 2016-07-13 15:31:59.316 screenresolution[1643:7447] starting screenresolution argv=screenresolution get 15:31:59 INFO - 2016-07-13 15:31:59.319 screenresolution[1643:7447] Display 0: 1600x1200x32@60 15:31:59 INFO - 2016-07-13 15:31:59.324 screenresolution[1644:7450] starting screenresolution argv=screenresolution list 15:31:59 INFO - Available Modes on Display 0 15:31:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:31:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:31:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:31:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:31:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:31:59 INFO - Intel Iris: 15:31:59 INFO - Chipset Model: Intel Iris 15:31:59 INFO - Type: GPU 15:31:59 INFO - Bus: Built-In 15:31:59 INFO - VRAM (Dynamic, Max): 1536 MB 15:31:59 INFO - Vendor: Intel (0x8086) 15:31:59 INFO - Device ID: 0x0a2e 15:31:59 INFO - Revision ID: 0x0009 15:31:59 INFO - Displays: 15:31:59 INFO - Display: 15:31:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:31:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:31:59 INFO - Display Serial Number: 1600x1200 60 15:31:59 INFO - Main Display: Yes 15:31:59 INFO - Mirror: Off 15:31:59 INFO - Online: Yes 15:31:59 INFO - Rotation: Supported 15:31:59 INFO - Return code: 0 15:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:31:59 INFO - Python 2.7.3 15:31:59 INFO - Return code: 0 15:31:59 INFO - grabbing minidump binary from tooltool 15:31:59 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')]} 15:31:59 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 0x109f04d30>, '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 0x109c69db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109efcb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:31:59 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 15:31:59 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 15:31:59 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 15:31:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:31:59 INFO - Return code: 0 15:31:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:31:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:31:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:31:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:31:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 15:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0388 --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 15:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.s139zN1pHh/Render', 15:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:31:59 INFO - 'HOME': '/Users/cltbld', 15:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:31:59 INFO - 'LOGNAME': 'cltbld', 15:31:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:31:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:59 INFO - 'MOZ_NO_REMOTE': '1', 15:31:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:31:59 INFO - 'NO_EM_RESTART': '1', 15:31:59 INFO - 'PAGER': '/bin/cat', 15:31:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:59 INFO - 'PWD': '/builds/slave/test', 15:31:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:31:59 INFO - 'SHELL': '/bin/bash', 15:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.uDJusuSp7k/Listeners', 15:31:59 INFO - 'TMPDIR': '/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/', 15:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:31:59 INFO - 'USER': 'cltbld', 15:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:59 INFO - 'XPC_FLAGS': '0x0', 15:31:59 INFO - 'XPC_SERVICE_NAME': '0', 15:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:31:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0388', '--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 15:31:59 INFO - mozversion application_buildid: 20160713131643 15:31:59 INFO - mozversion application_changeset: bb5d09eec5eee960351a3a87aa30bbe87c25298d 15:31:59 INFO - mozversion application_display_name: Nightly 15:31:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:31:59 INFO - mozversion application_name: Firefox 15:31:59 INFO - mozversion application_remotingname: firefox 15:31:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:31:59 INFO - mozversion application_vendor: Mozilla 15:31:59 INFO - mozversion application_version: 50.0a1 15:31:59 INFO - mozversion platform_buildid: 20160713131643 15:31:59 INFO - mozversion platform_changeset: bb5d09eec5eee960351a3a87aa30bbe87c25298d 15:31:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:31:59 INFO - mozversion platform_version: 50.0a1 15:31:59 INFO - using testdate: 1468449119 15:31:59 INFO - actual date: 1468449119 15:31:59 INFO - starting webserver on 'localhost:49281' 15:31:59 INFO - SUITE-START | Running 2 tests 15:31:59 INFO - TEST-START | dromaeo_css 15:31:59 INFO - operating with platform_type : mac_ 15:31:59 INFO - Initialising browser for dromaeo_css test... 15:31:59 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpX78bdk/profile http://localhost:49281/getInfo.html) 15:32:02 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 15:32:02 INFO - PROCESS | 1654 | colorDepth:24 15:32:02 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 15:32:02 INFO - PROCESS | 1654 | __metrics 15:32:02 ERROR - PROCESS | 1654 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:32:03 INFO - TEST-INFO | 1654: exit 0 15:32:03 INFO - Browser initialized. 15:32:03 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:03 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpX78bdk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:15 INFO - PROCESS | 1657 | RSS: Main: 254660608 15:32:15 INFO - PROCESS | 1657 | 15:33:05 INFO - PROCESS | 1657 | 1468449185365 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] 15:35:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49281/tests/dromaeo/cssquery-ext.html) 15:35:17 INFO - PROCESS | 1657 | RSS: Main: 268693504 15:35:17 INFO - PROCESS | 1657 | 15:38:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-ext.html (next: http://localhost:49281/tests/dromaeo/cssquery-jquery.html) 15:38:20 INFO - PROCESS | 1657 | RSS: Main: 277311488 15:38:20 INFO - PROCESS | 1657 | 15:41:22 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49281/tests/dromaeo/cssquery-mootools.html) 15:41:23 INFO - PROCESS | 1657 | RSS: Main: 281985024 15:41:23 INFO - PROCESS | 1657 | 15:44:25 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49281/tests/dromaeo/cssquery-prototype.html) 15:44:25 INFO - PROCESS | 1657 | RSS: Main: 281395200 15:44:25 INFO - PROCESS | 1657 | 15:47:28 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49281/tests/dromaeo/cssquery-yui.html) 15:47:29 INFO - PROCESS | 1657 | RSS: Main: 284700672 15:47:29 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49281/tests/dromaeo/cssquery-yui.html (next: http://localhost:49281/tests/dromaeo/cssquery-dojo.html) 15:50:31 INFO - PROCESS | 1657 | RSS: Main: 284839936 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | __start_tp_report 15:50:31 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 15:50:31 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 15:50:31 INFO - PROCESS | 1657 | |i|pagename|runs| 15:50:31 INFO - PROCESS | 1657 | |0;dojo.html;2808.8455134967576;3400.4219282721933;3409.9088291746634;3416.2313479467116;3451.0682115828745;5845.2985641723;5866.677332746703;5918.940810591893;5932.139839723238;5949;5719.942800571993;5901.49837263832;5911.615744976573;5937.64374137552;6032.909506357408;5204.115300398932;5254.15933450646;5287.259783630295;5316.680999140045;5372.274742909696;5206.427292997786;5373.032854086263;5400.91898621521;5446;5451.209574611698;5205.583553315763;5252.6323157379;5260.894782104337;5268.341457317835;5271.051210782058;4560;5140.740518572936;5297.47025297471;5301;5306.681599104066;4828.5412885775795;5292.682439053669;5298.576113910878;5302.09864323066;5303.681779093228;5648;5739.770409183628;5821.912671309934;5892.970535147339;5951.4048595140575;6209.348018458088;6252.5615010146075;6265.122882796412;6266.843328916768;6282.717277722513;5694.402087780806;5857.297124345063;6320.683965801738;6322.304546499881;6341.936580634181;5899.911501327483;5955.761769529214;5994.190784244159;5998.3401825799565;6031.577789554689;6361.936380636227;6394.488440924715;6410.294867564564;6432.421082102634;6432.839179020562;6093.2326056351785;6158.445739883432;6276.874462510724;6281.528885333618;6293.213348331458;6220.906686399708;6283.2460104787715;6307.085472606446;6313.55805093639;6318.589291696025;4717.504662010508;6115.027386288435;6126.23422072241;6196;6316.084167795644;6139.185504090456;6161.291451483136;6254.530910181755;6276.717547710364;6296.748130074746;4937.925931111036;4979.90040199194;4986.950130498722;4991.850244492671;5034.34553508049;4429.490608580055;4458.308962110878;4462.776861156929;4474.619657329098;4481.260592002283;5847.210626565445;5979.461848433575;6033.034714445667;6033.215681961317;6070.848228794315;6338.080978258126;6343.555951083472;6348.238211414659;6357.4914006879335;6366.108744775735;5989.371116032754;6039.184710064085;6048.334683184846;6070.939290607037;6072.605280656831;5379.892402152013;5455.399906010336;5491.643043202179;5525.530329921921;5561.944380556223;6423.070784454579;6464.256610489854;6467.935320646733;6479.222493300834;6479.838004049937;5969.582129250911;6305;6305.4009869062365;6310.432061114522;6344.175257216532;6243.531735119975;6381.617102973651;6387.137736405712;6425;6477.157969464128;6207.906881396873;6227.626342419469;6261.7182226799;6273.62358258506;6275.121482992476;6163.3528479509005;6315.778947736807;6321.30465648769;6331.303556608677;6334.619922804646;5120.923186152285;5908.881822363614;6108.918862504554;6130.6628135452975;6180.103884936749;6110.816675499742;6218.533609979179;6221.440070393686;6222;6278.560500764903;5482.479164479368;6047.5464340173785;6178.66017369049;6180.536459765445;6190.3190649029475;6054.939450605438;6117.480721074193;6152.538559608137;6229.750809967732;6242.687865606611;6145.8156255312415;6151.784687535915;6163.229596300463;6163.599366041193;6313.779017734541 15:50:31 INFO - PROCESS | 1657 | |1;ext.html;476.6639519139007;484.32920405238735;534.6791924845094;542.9484199001093;576.668415660995;31040.53439198411;41043.17913641729;41845.37231941523;42024.369634455434;42123.78938105309;41298.7935060325;41353.58646413543;42309.78845105778;42983.14033719324;43181;9654.227661787076;9799.706008819747;9808.362456440309;9815.901840981605;9818.067283608081;9734.561944712505;9826.754331141707;9841;9848.06443387877;9881.555330010167;9836.31145819793;9840.261980351466;9890;9895;9910.108090271875;8273.46222495536;8574.885264915521;9831.360961537514;9881.308308418449;9909.405435673847;9709.417434953926;9711.68892199551;9745.658901938468;9805.950970245174;9807.509624518745;33785.32429351424;41540.376894346606;41618.58381416177;41667.583324166975;41747.79126104381;3644.0889777555612;3742;3792.7345085844004;3802.2205447883116;4373.169097871426;26150.86924565384;28334.716652833413;32355;33986;34392.31215375703;3205.3589282143666;3336.349411864687;3376;3401.115709915415;3424.760266781326;524464;529128;537362;537566.999999996;537603;66066;70658;71051.28948710447;71319.64340178265;71634.99999999895;73958;74065.88901166487;74478.25521744821;74928.62535687396;75130.24869751342;17751.49112325441;17890.91054544719;17978.460646180636;17981.370652027115;18004.279828806964;13100.082994190316;13330.73338533224;13425.664358390923;13452.865471345356;13458.596242112751;20869.165233390493;21650.56698866014;21711.457213569473;21713.891430542746;21760.238391656218;7340.596267205355;8758.693445729368;8797.692080777142;8890.911090889138;9024.729258122266;880.7709995401242;934.1032608695592;967.1247520993512;994.9253805964437;1033.3982327392512;31518;31685.683143168735;31746.523802142987;31880.36239275248;32240.83879580587;911.293747345799;1082.8484012238293;1083.664064140119;1105.2649987758211;1108.5842808946645;13652;16092.953957992693;16314.124372352198;16596.17019149038;16654.00075995444;685525;699612;705353;707586;709690;62768.372316277164;62833.057504137476;62840.685796570724;62890;63158.26313026541;1421.3745951781184;1444.270643325135;1456.4829485532696;1494.1707352419512;1525.6643538421529;26265.868670656524;33544.605603019874;33608.83195584006;33626.82306119274;33921.66078339185;56723.71638141783;56966;57659;57735.1339729896;57878.7106064467;619270;634330;645603;645836;646017;45967;46710.06579868452;47218;47458;47979.760101199274;48866.02267954692;49221;49868.25197621966;50142.24786628276;50388.74805626095;40868.79565602153;41024.38463423111;41145.58854411537;41809.581904180566;42303;41044.58955410407;41328.79335603303;41450.963725907095;41849.79075104605;42277.78861105675;35369.29261414706;39165.412518811674;41358.586414135476;41379.379309310985;42198;32798.01605951825;33558;34203.631854726525;36598.08504787402;37472.250554988204;23103;24144.72967215837;27422.45155096847;27714.861425692743;28074.157775266776 15:50:31 INFO - PROCESS | 1657 | |2;jquery.html;378.28315342426106;381.56311023877663;387.21108478827813;396.5717025612339;408.47714924896127;19561.608767824637;21402.46493837655;21556.8922155389;21622;21677.67483487747;20254.29109981151;21295.935203239816;21369.0383932723;21560.460988475297;21916.45208869779;4701.811927522895;5537.695426751517;6177.66022868742;6203.8138855834395;6213.720382582772;3213.2609499815057;6058.969975104243;6531.150950376468;6887.207971083314;6895.103636527245;6801.523893327469;6813.4208592269715;6900.654967251642;6913.827154321132;6915.135608048994;6667.399934005938;6790.388865002174;6817.386435220829;6828.897566536456;6880.655967201645;5812.709364531756;5937.643741375531;6015.639061656271;6053.848653783691;6070.908936365958;13349;13825.585232443043;13840.653983650389;13890.95817813668;13913;2115.111653105699;2291.2209848651537;2564.8589327586974;2936.750376218024;3007.3684526249294;10329.431881246528;10401.739956501073;10430.16558675304;10448.111910487618;13070;1833.1842330163083;1912.5110931626182;1952.9023548822502;2008.2067583304513;2044.0554772676587;127129;128420;129375;131409.0288645671;132896.33551832277;10662.626808061836;10777.245592808427;11528.711782205512;11844.28934263947;11984;14743.262836858114;14842.480513181987;14947.551573452814;14976.925115374353;14982.175980321186;7238.384737297283;8714.128587141235;8912.8663070054;8929.687460938965;8995.235404990519;7335.4498412618195;8773;8932.553372331487;8951.418157819851;9051.959024712243;4589.701669391479;4626.653001024936;4663.160631086437;4706.552877476634;4729.62163026957;1781.145050375827;1875.446743210756;2002.299195281669;2005;2031.492126968258;831.9459235149817;862.8188080503039;876.609908590671;905.4341036851968;1031.5358088860044;16287;21185.199258063236;21193.576128477343;21572.352829415144;22120.668189977165;897.4480694372913;902.670525258276;939.6100618243489;985.1626117799813;991.6380521109887;10570.837207907123;11454.599089031844;11725.237859539102;11804.940975295069;11821.76356472883;483394;488241;491272;529496;614796;125481;147200;150209;151058;155089;992.7270000749708;1002.1982414068716;1039.293280569205;1039.838824982129;1040.1626690514058;19447.8055219446;19905.60188796245;19996.300129495397;20164.29424970119;20168.59662806765;39233.41149882697;52651.73674131605;58266.417335826096;58348.416515834295;58789.4121058801;67821.6608916972;70482;86039;87069.56465217633;87946.1205387938;7132.215456299907;7459.992900958301;8100.513969161869;8205.491974842951;8365.539895305574;7194.352508274071;11180.217384782987;11212.775744485229;12982.480700771863;13138.277394743382;11308.095352371625;11406.429678515875;11409.087273018305;11590.536378544764;11627.825582616437;8657.437266577652;11000;11081.50133244022;11340.659780206606;11448.828267575826;11359.886401135884;11596.246243994114;11805.527778888749;11852.762944740884;11857.466414011562;8106.918930810616;8258.504489730636;8266.421350505407;8278.875816862632;8429.789255268668;9634.181094607036;10866;11305.830412543653;11513.654590362303;11518.36648984314 15:50:31 INFO - PROCESS | 1657 | |3;mootools.html;1512.1456377146912;1562.3750499800078;1823.972640410394;1881.9811801881986;1945.7178709087175;8033.558154301511;8543.188397102282;8562.785930351736;9046.823912891323;9069.365144439891;8727.781805454852;8836.072212417685;8876.289896808255;8886.688965886195;8901.955490222539;2370.170440345874;2400.939976500593;2401.4236583220077;2402.0752010475917;2408.9638655420094;2343.753905839888;2379.357573455166;2391.8325717199805;2396.940076498084;2402.447437089462;2363.3382652857226;2378.988105059472;2384.1059602649007;2405.170216275391;2408.301592538162;2330.673705681206;2379.9881000594974;2384.3443053160345;2388.6178211486167;2391.7727815857465;2334.101370972171;2339.801116905065;2356.02225076593;2367.3726462487452;2367.822413319008;8922.643094276222;8940.374173807835;8960.686375976875;8966.148215919477;8979.236764874993;5171.948280517222;5315.654482458628;5326.520613144797;5331.813386531491;5364;3583.4087375583;3596.28074385124;3636.690881275095;3675.3016926784094;3687.483752274684;1095.8137116690182;1095.9616413425572;1100.4387762241315;1106.80630889594;1121.1311233793795;11571;11705.941470292593;11732.589359372381;11741.765164696744;11757.88242117585;4565.315202719618;4603;4743.241081426955;4751.976240118777;4795.784189711471;10024.298299118991;10041.949790251001;10053.095221430107;10056.74858128538;10064.245181611263;5251.2123181523075;5278.762455689426;5337.679739215582;5349.705766182898;5354.946450535523;4380.342948557742;4620.792064357112;4748.596369308648;4789.401324834395;4879.56083952446;3623.166671665532;3843.0008197868756;3989.261986532501;4038.212548553004;4043.2924238258774;1263.759885621729;1270.866559011309;1276.8786965238287;1280.1998750780763;1284.7494738525897;773.7988123088038;817.4441379861751;893.5621545442816;910.3263584947091;945.669015844449;4425.579569940851;5627.493525582717;5961.791337303173;6040.214772079602;6077.1491991121275;973.3819024919227;988.9011098890197;1018.4500369800224;1018.6689325969089;1026.373911913732;3308.5368048473233;4105.281575724236;4133.81397837098;4198.223328684203;4199.643030342394;9855.901440985499;10347.793044139225;10477.580896764044;10933.180011499011;11065.336079835235;8979.371443998987;10011.449370284705;10459.477026148663;10658.893411065945;10915.235933484739;7921.089074756362;8224.588770561448;8226.753197403968;8266.710665126811;8286.337093032544;5364.8122315718765;5650.491455769001;5935.436133567304;5938.792142275;6195.783147589813;9775.80448391014;9836.917939026844;9925.702228933143;10022.849657255001;10087.04173103554;7747.961260193663;9010;10191.643292485023;10308.484575771032;10345.120664743581;7601.581912994839;8156.469829461066;8330.208630180123;8431.283340915845;8468.788280293042;8515.574221289035;8550.82898342042;8589.613467394107;8637.56812159377;8657.783555410913;7332.633368331455;7507.324340809353;7570.886436703344;7590.127135379281;7601;7198.20819709842;7230.060092188192;7300.634968251672;7352.816179595553;7414.66634001482;7136.464765142531;7208.783736487913;7213.170485394037;7213.567185968858;7243.203247642649;4859.635527335393;5014.129554856918;5020.698758074527;5032;5061.569766569735;4957.504249575014;5027.924581131213;5041.924371134362;5045.5459008689395;5136.8202112925865 15:50:31 INFO - PROCESS | 1657 | |4;prototype.html;277.83191169342547;306.53100755843553;316.41621208869634;317.0551755767813;320.0558352859065;4540.500544940062;5460.945390546093;5517.724113794315;5526.281583394159;5710.857228569288;5328.040952628535;5534.75093620787;5628.831135065944;5635.492805647491;5684.442001099512;4117.629413352797;4260.637845783112;4276.743395396286;4282.828686852522;4286.142771445708;3511.227529943408;4121.608447197512;4204.642605378546;4279.967015667564;4281.272183728758;4210.410542524034;4221.831126754926;4230.280852255124;4247.320428731404;4292.635126014293;3668.449732540127;4255.936160957588;4261.637760790337;4268.381084742695;4280.850170244058;2920.4889144399644;3672.394054980925;3675.0628589709722;3676.191237927652;3683.907902302437;5262.947370526284;5558.055130627803;5561.944380556223;5562.803997140634;5575.916361254584;4046.61557152073;4946.505349465025;4951.876203094916;4982.427020892571;4984.352034235526;5365.841472858527;5919.67229493455;6045.737754882841;6068.150458935753;6121.387861213888;3817.8854634361014;4034.979825100885;4037.212743515016;4042.393640953851;4067.3085575452246;5232.895342093137;6328.019157030668;6332.778352757631;6341.3341599132345;6389.73164526591;3430.8849623872343;4109.671226301889;4119.958800411958;4136.420901073852;4151.211269858717;3131.4989601663624;3394.3890099781784;3744;3885.3589157788647;4095.3447448408706;3440.9827950860085;4186.832526698959;4838.467768545457;4848.927266091011;4891.3396691446915;5402.297701298806;5654.802081927113;5694.772209111672;6004.609700369462;6041.2750469943885;1365.6654119740726;1399.762040453105;1403.2913378743874;1405.7488834936914;1407.5572538148276;750.4784174998324;836.9121242269596;862.5040601654074;868.522312727997;868.8740132680726;4231.196072746168;4429.9778501107285;4715.669903106818;4773.880652983634;4812.639052071038;4374.156798081272;4571.954280457219;5173.301604283449;5262.97368513155;5287.947120528823;4068.4914385701786;4112.444819949268;4125.608067233608;4689.859304220879;4754.690945088558;2799.866054248033;2966.569847372119;3224.193951512122;3278.950815737766;3281.868725251011;5937.851553711192;6440.806775796734;6500.577462465019;6512.641804700787;6525.869482610321;5182.844514664566;5368.3826359968325;6045.395460454008;6353.904691429632;6507.609543427409;6349.492040636738;6455.935440645533;6481.416672499403;6498.740050398026;6521.445677117308;5939.3466718661775;6230.034344676583;6249;6317.494600432046;6357.396047375492;6061.939380606137;6129.08063790435;6135.570510064253;6141.539384546088;6199.318075011655;6237.425551777999;6451.838564126207;6483.578567393104;6492.870142597216;6498.415142636996;3299.686529779667;3984;4053.189362127527;4054.3513037914972;4060.654844338146;4594.494605593315;6140.964409184426;6153.600015998945;6183.381661833961;6203;4599.333096700892;5944.940550594439;5968.432998865101;6057.183409714504;6060.90908636362;5234.869128271824;5969.940300596939;6057.575969682256;6082.2701275847185;6087.208662873798;5771.701367192348;5831.591788574759;5907.675077870758;5914.166608351425;5942.286925568959;6071.332153463204;6082.513398928164;6099.939000610115;6109.969450152721;6128.233970753656;4898.8775280618265;5534;5920.579061025409;5958.731857066356;6006.609570377911 15:50:31 INFO - PROCESS | 1657 | |5;yui.html;724.9198693946022;735.9889601655976;771.1324759645399;782.6830133795813;790.6679194738209;15505.92247038766;15553.844461555382;16027.278772455238;16167.676646467064;16247.025178489284;14738.926305368459;14869.256537173153;14902.105873647588;14907.403703851833;14926.62683432912;719.8632259870634;882.4352414454754;889.5552223888039;912.7672443526891;912.8083102548472;904.8371293167228;908.9318301127408;915.4187091197072;916.0701887584107;918.5820451694497;954.1174413667364;965.1120968708805;966.2366730283068;969.5976169889523;971.0386717150006;944.8960614332418;953.6471505542925;961.1733908838394;961.427950369529;964.0744884910495;688.9321551595008;702.3012102957539;722.32823474169;726.0162479839794;726.4769366056431;15569.143697096655;15576.221188940508;15586.844131558653;15633.140177290245;15920.771092047122;15017.849821501755;15026.09843409388;15151.469698560497;15172;15195.62010949724;12059.758804823854;12272.938635306766;12544.560940367044;12580;12624.68438289041;3884.2814079395403;3889.2221555688693;4102.856400026015;4120.381942708587;4122.835086596532;121424;124077.75922240842;124813;128552;133484.6651533482;11664.825027624593;11708.829117088393;11779;11828.116942361848;11899.76200476003;24610.5077898441;25008.49983000366;25025.124120655688;25042.37394065163;25069.62395564068;8393.370497212734;8403.15968403167;8415.158484151536;8468;8693.869591956125;4092.815823287959;4580.1068791585985;4651.232546629836;4683.672142949961;4776.307435421914;3132.4988001920037;3583.211693427494;3656.945145822815;3683.1344634010984;3690.3357395669036;532.5233915645475;615.6552330694825;616.7748771698298;647.155462121926;658.6212927566669;577.1429427300455;639.8336432527576;640.6668532363238;690.5062880040795;704.3344039882262;8543.572821359032;9213.723588292361;9279.860802087975;9346.953265233631;9389.342746007715;520.8359366799446;559.1249694228601;589.0927970924813;617.9011358182669;661.272600139852;3973.245083434196;4605.171069207575;4605.65457590682;4609.262517997105;4652.55800698933;102149.48925255475;102620.48689756653;153850;167041;169384;131980;150628.70284728688;152697.12862921195;152881.23559382354;156876.21561892118;75945.24054759492;79497.60251198823;83990.58004709937;84220;118141;8811.427257228259;8856.822863542822;8875.822483550422;8881.777955551162;9030.142136497023;41386.79306603448;66906.66546667235;67682.9847552297;69811;71820.64089679727;91994;94272;94583.05416945742;96574.51712741391;97551;13760.65598360049;13789;13825.51610693621;13877.097988630707;13948.930255349063;15191.088534687955;15403.306851191948;15602.141882196589;15948.521544353687;16153.838461615233;13874.861251387762;13977.790333144807;14030.368633411725;14082.718345633235;14132.576022719335;13235.139715918434;13264.094218202752;13376.464941402235;13463.528776492776;14004.159750415009;13813.723725525233;14100.294985250901;14184.29078546048;14272.785908211177;14460.445554119024;11254.493547790205;11403.543858245577;11508.769824603629;11602.6519204424;12009.699757506132;9520.476373799507;10589.576416943544;10970.945145274223;11569.6529104127;11867.881321187024 15:50:31 INFO - PROCESS | 1657 | __end_tp_report 15:50:31 INFO - PROCESS | 1657 | __start_cc_report 15:50:31 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,437 15:50:31 INFO - PROCESS | 1657 | __end_cc_report 15:50:31 INFO - PROCESS | 1657 | __startTimestamp1468450231751__endTimestamp 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | ------- Summary: start ------- 15:50:31 INFO - PROCESS | 1657 | Number of tests: 6 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5816.43 Median:6070.94 stddev:675.42 (11.1%) stddev-sans-first:634.94 15:50:31 INFO - PROCESS | 1657 | Values: 2808.8 3400.4 3409.9 3416.2 3451.1 5845.3 5866.7 5918.9 5932.1 5949.0 5719.9 5901.5 5911.6 5937.6 6032.9 5204.1 5254.2 5287.3 5316.7 5372.3 5206.4 5373.0 5400.9 5446.0 5451.2 5205.6 5252.6 5260.9 5268.3 5271.1 4560.0 5140.7 5297.5 5301.0 5306.7 4828.5 5292.7 5298.6 5302.1 5303.7 5648.0 5739.8 5821.9 5893.0 5951.4 6209.3 6252.6 6265.1 6266.8 6282.7 5694.4 5857.3 6320.7 6322.3 6341.9 5899.9 5955.8 5994.2 5998.3 6031.6 6361.9 6394.5 6410.3 6432.4 6432.8 6093.2 6158.4 6276.9 6281.5 6293.2 6220.9 6283.2 6307.1 6313.6 6318.6 4717.5 6115.0 6126.2 6196.0 6316.1 6139.2 6161.3 6254.5 6276.7 6296.7 4937.9 4979.9 4987.0 4991.9 5034.3 4429.5 4458.3 4462.8 4474.6 4481.3 5847.2 5979.5 6033.0 6033.2 6070.8 6338.1 6343.6 6348.2 6357.5 6366.1 5989.4 6039.2 6048.3 6070.9 6072.6 5379.9 5455.4 5491.6 5525.5 5561.9 6423.1 6464.3 6467.9 6479.2 6479.8 5969.6 6305.0 6305.4 6310.4 6344.2 6243.5 6381.6 6387.1 6425.0 6477.2 6207.9 6227.6 6261.7 6273.6 6275.1 6163.4 6315.8 6321.3 6331.3 6334.6 5120.9 5908.9 6108.9 6130.7 6180.1 6110.8 6218.5 6221.4 6222.0 6278.6 5482.5 6047.5 6178.7 6180.5 6190.3 6054.9 6117.5 6152.5 6229.8 6242.7 6145.8 6151.8 6163.2 6163.6 6313.8 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:77016.68 Median:42306.39 stddev:167938.09 (397.0%) stddev-sans-first:168310.88 15:50:31 INFO - PROCESS | 1657 | Values: 476.7 484.3 534.7 542.9 576.7 31040.5 41043.2 41845.4 42024.4 42123.8 41298.8 41353.6 42309.8 42983.1 43181.0 9654.2 9799.7 9808.4 9815.9 9818.1 9734.6 9826.8 9841.0 9848.1 9881.6 9836.3 9840.3 9890.0 9895.0 9910.1 8273.5 8574.9 9831.4 9881.3 9909.4 9709.4 9711.7 9745.7 9806.0 9807.5 33785.3 41540.4 41618.6 41667.6 41747.8 3644.1 3742.0 3792.7 3802.2 4373.2 26150.9 28334.7 32355.0 33986.0 34392.3 3205.4 3336.3 3376.0 3401.1 3424.8 524464.0 529128.0 537362.0 537567.0 537603.0 66066.0 70658.0 71051.3 71319.6 71635.0 73958.0 74065.9 74478.3 74928.6 75130.2 17751.5 17890.9 17978.5 17981.4 18004.3 13100.1 13330.7 13425.7 13452.9 13458.6 20869.2 21650.6 21711.5 21713.9 21760.2 7340.6 8758.7 8797.7 8890.9 9024.7 880.8 934.1 967.1 994.9 1033.4 31518.0 31685.7 31746.5 31880.4 32240.8 911.3 1082.8 1083.7 1105.3 1108.6 13652.0 16093.0 16314.1 16596.2 16654.0 685525.0 699612.0 705353.0 707586.0 709690.0 62768.4 62833.1 62840.7 62890.0 63158.3 1421.4 1444.3 1456.5 1494.2 1525.7 26265.9 33544.6 33608.8 33626.8 33921.7 56723.7 56966.0 57659.0 57735.1 57878.7 619270.0 634330.0 645603.0 645836.0 646017.0 45967.0 46710.1 47218.0 47458.0 47979.8 48866.0 49221.0 49868.3 50142.2 50388.7 40868.8 41024.4 41145.6 41809.6 42303.0 41044.6 41328.8 41451.0 41849.8 42277.8 35369.3 39165.4 41358.6 41379.4 42198.0 32798.0 33558.0 34203.6 36598.1 37472.3 23103.0 24144.7 27422.5 27714.9 28074.2 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:33630.40 Median:21797.06 stddev:89208.58 (409.3%) stddev-sans-first:89423.90 15:50:31 INFO - PROCESS | 1657 | Values: 378.3 381.6 387.2 396.6 408.5 19561.6 21402.5 21556.9 21622.0 21677.7 20254.3 21295.9 21369.0 21560.5 21916.5 4701.8 5537.7 6177.7 6203.8 6213.7 3213.3 6059.0 6531.2 6887.2 6895.1 6801.5 6813.4 6900.7 6913.8 6915.1 6667.4 6790.4 6817.4 6828.9 6880.7 5812.7 5937.6 6015.6 6053.8 6070.9 13349.0 13825.6 13840.7 13891.0 13913.0 2115.1 2291.2 2564.9 2936.8 3007.4 10329.4 10401.7 10430.2 10448.1 13070.0 1833.2 1912.5 1952.9 2008.2 2044.1 127129.0 128420.0 129375.0 131409.0 132896.3 10662.6 10777.2 11528.7 11844.3 11984.0 14743.3 14842.5 14947.6 14976.9 14982.2 7238.4 8714.1 8912.9 8929.7 8995.2 7335.4 8773.0 8932.6 8951.4 9052.0 4589.7 4626.7 4663.2 4706.6 4729.6 1781.1 1875.4 2002.3 2005.0 2031.5 831.9 862.8 876.6 905.4 1031.5 16287.0 21185.2 21193.6 21572.4 22120.7 897.4 902.7 939.6 985.2 991.6 10570.8 11454.6 11725.2 11804.9 11821.8 483394.0 488241.0 491272.0 529496.0 614796.0 125481.0 147200.0 150209.0 151058.0 155089.0 992.7 1002.2 1039.3 1039.8 1040.2 19447.8 19905.6 19996.3 20164.3 20168.6 39233.4 52651.7 58266.4 58348.4 58789.4 67821.7 70482.0 86039.0 87069.6 87946.1 7132.2 7460.0 8100.5 8205.5 8365.5 7194.4 11180.2 11212.8 12982.5 13138.3 11308.1 11406.4 11409.1 11590.5 11627.8 8657.4 11000.0 11081.5 11340.7 11448.8 11359.9 11596.2 11805.5 11852.8 11857.5 8106.9 8258.5 8266.4 8278.9 8429.8 9634.2 10866.0 11305.8 11513.7 11518.4 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5730.24 Median:4827.71 stddev:3181.73 (65.9%) stddev-sans-first:3174.86 15:50:31 INFO - PROCESS | 1657 | Values: 1512.1 1562.4 1824.0 1882.0 1945.7 8033.6 8543.2 8562.8 9046.8 9069.4 8727.8 8836.1 8876.3 8886.7 8902.0 2370.2 2400.9 2401.4 2402.1 2409.0 2343.8 2379.4 2391.8 2396.9 2402.4 2363.3 2379.0 2384.1 2405.2 2408.3 2330.7 2380.0 2384.3 2388.6 2391.8 2334.1 2339.8 2356.0 2367.4 2367.8 8922.6 8940.4 8960.7 8966.1 8979.2 5171.9 5315.7 5326.5 5331.8 5364.0 3583.4 3596.3 3636.7 3675.3 3687.5 1095.8 1096.0 1100.4 1106.8 1121.1 11571.0 11705.9 11732.6 11741.8 11757.9 4565.3 4603.0 4743.2 4752.0 4795.8 10024.3 10041.9 10053.1 10056.7 10064.2 5251.2 5278.8 5337.7 5349.7 5354.9 4380.3 4620.8 4748.6 4789.4 4879.6 3623.2 3843.0 3989.3 4038.2 4043.3 1263.8 1270.9 1276.9 1280.2 1284.7 773.8 817.4 893.6 910.3 945.7 4425.6 5627.5 5961.8 6040.2 6077.1 973.4 988.9 1018.5 1018.7 1026.4 3308.5 4105.3 4133.8 4198.2 4199.6 9855.9 10347.8 10477.6 10933.2 11065.3 8979.4 10011.4 10459.5 10658.9 10915.2 7921.1 8224.6 8226.8 8266.7 8286.3 5364.8 5650.5 5935.4 5938.8 6195.8 9775.8 9836.9 9925.7 10022.8 10087.0 7748.0 9010.0 10191.6 10308.5 10345.1 7601.6 8156.5 8330.2 8431.3 8468.8 8515.6 8550.8 8589.6 8637.6 8657.8 7332.6 7507.3 7570.9 7590.1 7601.0 7198.2 7230.1 7300.6 7352.8 7414.7 7136.5 7208.8 7213.2 7213.6 7243.2 4859.6 5014.1 5020.7 5032.0 5061.6 4957.5 5027.9 5041.9 5045.5 5136.8 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4759.76 Median:5262.96 stddev:1544.90 (29.4%) stddev-sans-first:1512.16 15:50:31 INFO - PROCESS | 1657 | Values: 277.8 306.5 316.4 317.1 320.1 4540.5 5460.9 5517.7 5526.3 5710.9 5328.0 5534.8 5628.8 5635.5 5684.4 4117.6 4260.6 4276.7 4282.8 4286.1 3511.2 4121.6 4204.6 4280.0 4281.3 4210.4 4221.8 4230.3 4247.3 4292.6 3668.4 4255.9 4261.6 4268.4 4280.9 2920.5 3672.4 3675.1 3676.2 3683.9 5262.9 5558.1 5561.9 5562.8 5575.9 4046.6 4946.5 4951.9 4982.4 4984.4 5365.8 5919.7 6045.7 6068.2 6121.4 3817.9 4035.0 4037.2 4042.4 4067.3 5232.9 6328.0 6332.8 6341.3 6389.7 3430.9 4109.7 4120.0 4136.4 4151.2 3131.5 3394.4 3744.0 3885.4 4095.3 3441.0 4186.8 4838.5 4848.9 4891.3 5402.3 5654.8 5694.8 6004.6 6041.3 1365.7 1399.8 1403.3 1405.7 1407.6 750.5 836.9 862.5 868.5 868.9 4231.2 4430.0 4715.7 4773.9 4812.6 4374.2 4572.0 5173.3 5263.0 5287.9 4068.5 4112.4 4125.6 4689.9 4754.7 2799.9 2966.6 3224.2 3279.0 3281.9 5937.9 6440.8 6500.6 6512.6 6525.9 5182.8 5368.4 6045.4 6353.9 6507.6 6349.5 6455.9 6481.4 6498.7 6521.4 5939.3 6230.0 6249.0 6317.5 6357.4 6061.9 6129.1 6135.6 6141.5 6199.3 6237.4 6451.8 6483.6 6492.9 6498.4 3299.7 3984.0 4053.2 4054.4 4060.7 4594.5 6141.0 6153.6 6183.4 6203.0 4599.3 5944.9 5968.4 6057.2 6060.9 5234.9 5969.9 6057.6 6082.3 6087.2 5771.7 5831.6 5907.7 5914.2 5942.3 6071.3 6082.5 6099.9 6110.0 6128.2 4898.9 5534.0 5920.6 5958.7 6006.6 15:50:31 INFO - PROCESS | 1657 | 15:50:31 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:25439.75 Median:3886.75 stddev:40907.93 (1052.5%) stddev-sans-first:40980.60 15:50:31 INFO - PROCESS | 1657 | Values: 724.9 736.0 771.1 782.7 790.7 15505.9 15553.8 16027.3 16167.7 16247.0 14738.9 14869.3 14902.1 14907.4 14926.6 719.9 882.4 889.6 912.8 912.8 904.8 908.9 915.4 916.1 918.6 954.1 965.1 966.2 969.6 971.0 944.9 953.6 961.2 961.4 964.1 688.9 702.3 722.3 726.0 726.5 15569.1 15576.2 15586.8 15633.1 15920.8 15017.8 15026.1 15151.5 15172.0 15195.6 12059.8 12272.9 12544.6 12580.0 12624.7 3884.3 3889.2 4102.9 4120.4 4122.8 121424.0 124077.8 124813.0 128552.0 133484.7 11664.8 11708.8 11779.0 11828.1 11899.8 24610.5 25008.5 25025.1 25042.4 25069.6 8393.4 8403.2 8415.2 8468.0 8693.9 4092.8 4580.1 4651.2 4683.7 4776.3 3132.5 3583.2 3656.9 3683.1 3690.3 532.5 615.7 616.8 647.2 658.6 577.1 639.8 640.7 690.5 704.3 8543.6 9213.7 9279.9 9347.0 9389.3 520.8 559.1 589.1 617.9 661.3 3973.2 4605.2 4605.7 4609.3 4652.6 102149.5 102620.5 153850.0 167041.0 169384.0 131980.0 150628.7 152697.1 152881.2 156876.2 75945.2 79497.6 83990.6 84220.0 118141.0 8811.4 8856.8 8875.8 8881.8 9030.1 41386.8 66906.7 67683.0 69811.0 71820.6 91994.0 94272.0 94583.1 96574.5 97551.0 13760.7 13789.0 13825.5 13877.1 13948.9 15191.1 15403.3 15602.1 15948.5 16153.8 13874.9 13977.8 14030.4 14082.7 14132.6 13235.1 13264.1 13376.5 13463.5 14004.2 13813.7 14100.3 14184.3 14272.8 14460.4 11254.5 11403.5 11508.8 11602.7 12009.7 9520.5 10589.6 10970.9 11569.7 11867.9 15:50:31 INFO - PROCESS | 1657 | -------- Summary: end -------- 15:50:31 INFO - PROCESS | 1657 | 15:50:32 INFO - TEST-INFO | 1657: exit 0 15:50:32 INFO - TEST-OK | dromaeo_css | took 1112459ms 15:50:32 INFO - TEST-START | kraken 15:50:32 INFO - operating with platform_type : mac_ 15:50:32 INFO - Initialising browser for kraken test... 15:50:32 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpmERZua/profile http://localhost:49281/getInfo.html) 15:50:35 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 15:50:35 INFO - PROCESS | 1669 | colorDepth:24 15:50:35 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 15:50:35 INFO - PROCESS | 1669 | __metrics 15:50:35 ERROR - PROCESS | 1669 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 15:50:35 INFO - TEST-INFO | 1669: exit 0 15:50:35 INFO - Browser initialized. 15:50:35 INFO - Running cycle 1/1 for kraken test... 15:50:35 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/tmpmERZua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:47 INFO - PROCESS | 1671 | RSS: Main: 254246912 15:50:47 INFO - PROCESS | 1671 | 15:50:50 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection) 15:50:51 INFO - PROCESS | 1671 | RSS: Main: 267014144 15:50:51 INFO - PROCESS | 1671 | 15:50:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-dft) 15:50:54 INFO - PROCESS | 1671 | RSS: Main: 271142912 15:50:54 INFO - PROCESS | 1671 | 15:50:58 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-fft) 15:50:58 INFO - PROCESS | 1671 | RSS: Main: 271323136 15:50:58 INFO - PROCESS | 1671 | 15:51:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator) 15:51:01 INFO - PROCESS | 1671 | RSS: Main: 272257024 15:51:01 INFO - PROCESS | 1671 | 15:51:03 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:03 INFO - PROCESS | 1671 | RSS: Main: 273465344 15:51:03 INFO - PROCESS | 1671 | 15:51:06 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:07 INFO - PROCESS | 1671 | RSS: Main: 273547264 15:51:07 INFO - PROCESS | 1671 | 15:51:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:11 INFO - PROCESS | 1671 | RSS: Main: 273805312 15:51:11 INFO - PROCESS | 1671 | 15:51:14 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial) 15:51:15 INFO - PROCESS | 1671 | RSS: Main: 273891328 15:51:15 INFO - PROCESS | 1671 | 15:51:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:17 INFO - PROCESS | 1671 | RSS: Main: 273473536 15:51:17 INFO - PROCESS | 1671 | 15:51:19 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:19 INFO - PROCESS | 1671 | RSS: Main: 273342464 15:51:19 INFO - PROCESS | 1671 | 15:51:22 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:22 INFO - PROCESS | 1671 | RSS: Main: 273371136 15:51:22 INFO - PROCESS | 1671 | 15:51:25 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:26 INFO - PROCESS | 1671 | RSS: Main: 273485824 15:51:26 INFO - PROCESS | 1671 | 15:51:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:29 INFO - PROCESS | 1671 | RSS: Main: 273477632 15:51:29 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49281/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49281/tests/kraken/driver.html?testName=ai-astar) 15:51:31 INFO - PROCESS | 1671 | RSS: Main: 274726912 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | __start_tp_report 15:51:31 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 15:51:31 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 15:51:31 INFO - PROCESS | 1671 | |i|pagename|runs| 15:51:31 INFO - PROCESS | 1671 | |0;ai-astar;102;115;106;113;116;119;151;171;172;157 15:51:31 INFO - PROCESS | 1671 | |1;audio-beat-detection;143;109;138;152;110;131;128;110;155;110 15:51:31 INFO - PROCESS | 1671 | |2;audio-dft;197;200;201;207;233;255;194;203;221;229 15:51:31 INFO - PROCESS | 1671 | |3;audio-fft;70;83;79;167;61;59;58;61;145;79 15:51:31 INFO - PROCESS | 1671 | |4;audio-oscillator;70;71;122;70;74;75;109;67;72;109 15:51:31 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;86;88;86;78;86;135;122;90;74 15:51:31 INFO - PROCESS | 1671 | |6;imaging-darkroom;96;101;143;120;97;151;154;119;95;96 15:51:31 INFO - PROCESS | 1671 | |7;imaging-desaturate;105;137;90;90;89;149;153;91;138;143 15:51:31 INFO - PROCESS | 1671 | |8;json-parse-financial;57;57;57;59;55;61;87;88;87;85 15:51:31 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;68;67;69;65;75;73;67;75;74;71 15:51:31 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;82;86;89;87;85;82;88;84;87;85 15:51:31 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;138;136;135;130;156;147;149;134;175;136 15:51:31 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;168;165;228;226;212;218;184;167;209;162 15:51:31 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;68;67;66;67;70;69;65;67;68;70 15:51:31 INFO - PROCESS | 1671 | __end_tp_report 15:51:31 INFO - PROCESS | 1671 | __start_cc_report 15:51:31 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1104 15:51:31 INFO - PROCESS | 1671 | __end_cc_report 15:51:31 INFO - PROCESS | 1671 | __startTimestamp1468450291874__endTimestamp 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | ------- Summary: start ------- 15:51:31 INFO - PROCESS | 1671 | Number of tests: 14 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:132.20 Median:135.00 stddev:27.40 (20.3%) stddev-sans-first:26.80 15:51:31 INFO - PROCESS | 1671 | Values: 102.0 115.0 106.0 113.0 116.0 119.0 151.0 171.0 172.0 157.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:128.60 Median:134.50 stddev:18.16 (13.5%) stddev-sans-first:18.50 15:51:31 INFO - PROCESS | 1671 | Values: 143.0 109.0 138.0 152.0 110.0 131.0 128.0 110.0 155.0 110.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:214.00 Median:214.00 stddev:19.83 (9.3%) stddev-sans-first:20.06 15:51:31 INFO - PROCESS | 1671 | Values: 197.0 200.0 201.0 207.0 233.0 255.0 194.0 203.0 221.0 229.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:86.20 Median:65.50 stddev:38.25 (58.4%) stddev-sans-first:40.12 15:51:31 INFO - PROCESS | 1671 | Values: 70.0 83.0 79.0 167.0 61.0 59.0 58.0 61.0 145.0 79.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:70.50 stddev:20.73 (29.4%) stddev-sans-first:21.37 15:51:31 INFO - PROCESS | 1671 | Values: 70.0 71.0 122.0 70.0 74.0 75.0 109.0 67.0 72.0 109.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:93.40 Median:86.00 stddev:19.40 (22.6%) stddev-sans-first:20.51 15:51:31 INFO - PROCESS | 1671 | Values: 89.0 86.0 88.0 86.0 78.0 86.0 135.0 122.0 90.0 74.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:117.20 Median:124.50 stddev:24.12 (19.4%) stddev-sans-first:24.33 15:51:31 INFO - PROCESS | 1671 | Values: 96.0 101.0 143.0 120.0 97.0 151.0 154.0 119.0 95.0 96.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:118.50 Median:121.00 stddev:27.64 (22.8%) stddev-sans-first:28.88 15:51:31 INFO - PROCESS | 1671 | Values: 105.0 137.0 90.0 90.0 89.0 149.0 153.0 91.0 138.0 143.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:69.30 Median:73.00 stddev:15.11 (20.7%) stddev-sans-first:15.36 15:51:31 INFO - PROCESS | 1671 | Values: 57.0 57.0 57.0 59.0 55.0 61.0 87.0 88.0 87.0 85.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:72.00 stddev:3.69 (5.1%) stddev-sans-first:3.81 15:51:31 INFO - PROCESS | 1671 | Values: 68.0 67.0 69.0 65.0 75.0 73.0 67.0 75.0 74.0 71.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.50 stddev:2.37 (2.7%) stddev-sans-first:2.15 15:51:31 INFO - PROCESS | 1671 | Values: 82.0 86.0 89.0 87.0 85.0 82.0 88.0 84.0 87.0 85.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:143.60 Median:142.50 stddev:13.66 (9.6%) stddev-sans-first:14.33 15:51:31 INFO - PROCESS | 1671 | Values: 138.0 136.0 135.0 130.0 156.0 147.0 149.0 134.0 175.0 136.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:210.50 stddev:27.23 (12.9%) stddev-sans-first:27.22 15:51:31 INFO - PROCESS | 1671 | Values: 168.0 165.0 228.0 226.0 212.0 218.0 184.0 167.0 209.0 162.0 15:51:31 INFO - PROCESS | 1671 | 15:51:31 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.64 (2.4%) stddev-sans-first:1.73 15:51:31 INFO - PROCESS | 1671 | Values: 68.0 67.0 66.0 67.0 70.0 69.0 65.0 67.0 68.0 70.0 15:51:31 INFO - PROCESS | 1671 | -------- Summary: end -------- 15:51:31 INFO - PROCESS | 1671 | 15:51:32 INFO - TEST-INFO | 1671: exit 0 15:51:32 INFO - TEST-OK | kraken | took 60305ms 15:51:32 INFO - SUITE-END | took 1172s 15:51:33 INFO - Completed test suite (00:19:33) 15:51:33 INFO - javascript benchmark 15:51:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7579.842598654473, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2808.8455134967576, 3400.4219282721933, 3409.9088291746634, 3416.2313479467116, 3451.0682115828745, 5845.2985641723, 5866.677332746703, 5918.940810591893, 5932.139839723238, 5949.0, 5719.942800571993, 5901.49837263832, 5911.615744976573, 5937.64374137552, 6032.909506357408, 5204.115300398932, 5254.15933450646, 5287.259783630295, 5316.680999140045, 5372.274742909696, 5206.427292997786, 5373.032854086263, 5400.91898621521, 5446.0, 5451.209574611698, 5205.583553315763, 5252.6323157379, 5260.894782104337, 5268.341457317835, 5271.051210782058, 4560.0, 5140.740518572936, 5297.47025297471, 5301.0, 5306.681599104066, 4828.5412885775795, 5292.682439053669, 5298.576113910878, 5302.09864323066, 5303.681779093228, 5648.0, 5739.770409183628, 5821.912671309934, 5892.970535147339, 5951.4048595140575, 6209.348018458088, 6252.5615010146075, 6265.122882796412, 6266.843328916768, 6282.717277722513, 5694.402087780806, 5857.297124345063, 6320.683965801738, 6322.304546499881, 6341.936580634181, 5899.911501327483, 5955.761769529214, 5994.190784244159, 5998.3401825799565, 6031.577789554689, 6361.936380636227, 6394.488440924715, 6410.294867564564, 6432.421082102634, 6432.839179020562, 6093.2326056351785, 6158.445739883432, 6276.874462510724, 6281.528885333618, 6293.213348331458, 6220.906686399708, 6283.2460104787715, 6307.085472606446, 6313.55805093639, 6318.589291696025, 4717.504662010508, 6115.027386288435, 6126.23422072241, 6196.0, 6316.084167795644, 6139.185504090456, 6161.291451483136, 6254.530910181755, 6276.717547710364, 6296.748130074746, 4937.925931111036, 4979.90040199194, 4986.950130498722, 4991.850244492671, 5034.34553508049, 4429.490608580055, 4458.308962110878, 4462.776861156929, 4474.619657329098, 4481.260592002283, 5847.210626565445, 5979.461848433575, 6033.034714445667, 6033.215681961317, 6070.848228794315, 6338.080978258126, 6343.555951083472, 6348.238211414659, 6357.4914006879335, 6366.108744775735, 5989.371116032754, 6039.184710064085, 6048.334683184846, 6070.939290607037, 6072.605280656831, 5379.892402152013, 5455.399906010336, 5491.643043202179, 5525.530329921921, 5561.944380556223, 6423.070784454579, 6464.256610489854, 6467.935320646733, 6479.222493300834, 6479.838004049937, 5969.582129250911, 6305.0, 6305.4009869062365, 6310.432061114522, 6344.175257216532, 6243.531735119975, 6381.617102973651, 6387.137736405712, 6425.0, 6477.157969464128, 6207.906881396873, 6227.626342419469, 6261.7182226799, 6273.62358258506, 6275.121482992476, 6163.3528479509005, 6315.778947736807, 6321.30465648769, 6331.303556608677, 6334.619922804646, 5120.923186152285, 5908.881822363614, 6108.918862504554, 6130.6628135452975, 6180.103884936749, 6110.816675499742, 6218.533609979179, 6221.440070393686, 6222.0, 6278.560500764903, 5482.479164479368, 6047.5464340173785, 6178.66017369049, 6180.536459765445, 6190.3190649029475, 6054.939450605438, 6117.480721074193, 6152.538559608137, 6229.750809967732, 6242.687865606611, 6145.8156255312415, 6151.784687535915, 6163.229596300463, 6163.599366041193, 6313.779017734541], "value": 5771.939099416098, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.6639519139007, 484.32920405238735, 534.6791924845094, 542.9484199001093, 576.668415660995, 31040.53439198411, 41043.17913641729, 41845.37231941523, 42024.369634455434, 42123.78938105309, 41298.7935060325, 41353.58646413543, 42309.78845105778, 42983.14033719324, 43181.0, 9654.227661787076, 9799.706008819747, 9808.362456440309, 9815.901840981605, 9818.067283608081, 9734.561944712505, 9826.754331141707, 9841.0, 9848.06443387877, 9881.555330010167, 9836.31145819793, 9840.261980351466, 9890.0, 9895.0, 9910.108090271875, 8273.46222495536, 8574.885264915521, 9831.360961537514, 9881.308308418449, 9909.405435673847, 9709.417434953926, 9711.68892199551, 9745.658901938468, 9805.950970245174, 9807.509624518745, 33785.32429351424, 41540.376894346606, 41618.58381416177, 41667.583324166975, 41747.79126104381, 3644.0889777555612, 3742.0, 3792.7345085844004, 3802.2205447883116, 4373.169097871426, 26150.86924565384, 28334.716652833413, 32355.0, 33986.0, 34392.31215375703, 3205.3589282143666, 3336.349411864687, 3376.0, 3401.115709915415, 3424.760266781326, 524464.0, 529128.0, 537362.0, 537566.999999996, 537603.0, 66066.0, 70658.0, 71051.28948710447, 71319.64340178265, 71634.99999999895, 73958.0, 74065.88901166487, 74478.25521744821, 74928.62535687396, 75130.24869751342, 17751.49112325441, 17890.91054544719, 17978.460646180636, 17981.370652027115, 18004.279828806964, 13100.082994190316, 13330.73338533224, 13425.664358390923, 13452.865471345356, 13458.596242112751, 20869.165233390493, 21650.56698866014, 21711.457213569473, 21713.891430542746, 21760.238391656218, 7340.596267205355, 8758.693445729368, 8797.692080777142, 8890.911090889138, 9024.729258122266, 880.7709995401242, 934.1032608695592, 967.1247520993512, 994.9253805964437, 1033.3982327392512, 31518.0, 31685.683143168735, 31746.523802142987, 31880.36239275248, 32240.83879580587, 911.293747345799, 1082.8484012238293, 1083.664064140119, 1105.2649987758211, 1108.5842808946645, 13652.0, 16092.953957992693, 16314.124372352198, 16596.17019149038, 16654.00075995444, 685525.0, 699612.0, 705353.0, 707586.0, 709690.0, 62768.372316277164, 62833.057504137476, 62840.685796570724, 62890.0, 63158.26313026541, 1421.3745951781184, 1444.270643325135, 1456.4829485532696, 1494.1707352419512, 1525.6643538421529, 26265.868670656524, 33544.605603019874, 33608.83195584006, 33626.82306119274, 33921.66078339185, 56723.71638141783, 56966.0, 57659.0, 57735.1339729896, 57878.7106064467, 619270.0, 634330.0, 645603.0, 645836.0, 646017.0, 45967.0, 46710.06579868452, 47218.0, 47458.0, 47979.760101199274, 48866.02267954692, 49221.0, 49868.25197621966, 50142.24786628276, 50388.74805626095, 40868.79565602153, 41024.38463423111, 41145.58854411537, 41809.581904180566, 42303.0, 41044.58955410407, 41328.79335603303, 41450.963725907095, 41849.79075104605, 42277.78861105675, 35369.29261414706, 39165.412518811674, 41358.586414135476, 41379.379309310985, 42198.0, 32798.01605951825, 33558.0, 34203.631854726525, 36598.08504787402, 37472.250554988204, 23103.0, 24144.72967215837, 27422.45155096847, 27714.861425692743, 28074.157775266776], "value": 21456.41581724809, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.28315342426106, 381.56311023877663, 387.21108478827813, 396.5717025612339, 408.47714924896127, 19561.608767824637, 21402.46493837655, 21556.8922155389, 21622.0, 21677.67483487747, 20254.29109981151, 21295.935203239816, 21369.0383932723, 21560.460988475297, 21916.45208869779, 4701.811927522895, 5537.695426751517, 6177.66022868742, 6203.8138855834395, 6213.720382582772, 3213.2609499815057, 6058.969975104243, 6531.150950376468, 6887.207971083314, 6895.103636527245, 6801.523893327469, 6813.4208592269715, 6900.654967251642, 6913.827154321132, 6915.135608048994, 6667.399934005938, 6790.388865002174, 6817.386435220829, 6828.897566536456, 6880.655967201645, 5812.709364531756, 5937.643741375531, 6015.639061656271, 6053.848653783691, 6070.908936365958, 13349.0, 13825.585232443043, 13840.653983650389, 13890.95817813668, 13913.0, 2115.111653105699, 2291.2209848651537, 2564.8589327586974, 2936.750376218024, 3007.3684526249294, 10329.431881246528, 10401.739956501073, 10430.16558675304, 10448.111910487618, 13070.0, 1833.1842330163083, 1912.5110931626182, 1952.9023548822502, 2008.2067583304513, 2044.0554772676587, 127129.0, 128420.0, 129375.0, 131409.0288645671, 132896.33551832277, 10662.626808061836, 10777.245592808427, 11528.711782205512, 11844.28934263947, 11984.0, 14743.262836858114, 14842.480513181987, 14947.551573452814, 14976.925115374353, 14982.175980321186, 7238.384737297283, 8714.128587141235, 8912.8663070054, 8929.687460938965, 8995.235404990519, 7335.4498412618195, 8773.0, 8932.553372331487, 8951.418157819851, 9051.959024712243, 4589.701669391479, 4626.653001024936, 4663.160631086437, 4706.552877476634, 4729.62163026957, 1781.145050375827, 1875.446743210756, 2002.299195281669, 2005.0, 2031.492126968258, 831.9459235149817, 862.8188080503039, 876.609908590671, 905.4341036851968, 1031.5358088860044, 16287.0, 21185.199258063236, 21193.576128477343, 21572.352829415144, 22120.668189977165, 897.4480694372913, 902.670525258276, 939.6100618243489, 985.1626117799813, 991.6380521109887, 10570.837207907123, 11454.599089031844, 11725.237859539102, 11804.940975295069, 11821.76356472883, 483394.0, 488241.0, 491272.0, 529496.0, 614796.0, 125481.0, 147200.0, 150209.0, 151058.0, 155089.0, 992.7270000749708, 1002.1982414068716, 1039.293280569205, 1039.838824982129, 1040.1626690514058, 19447.8055219446, 19905.60188796245, 19996.300129495397, 20164.29424970119, 20168.59662806765, 39233.41149882697, 52651.73674131605, 58266.417335826096, 58348.416515834295, 58789.4121058801, 67821.6608916972, 70482.0, 86039.0, 87069.56465217633, 87946.1205387938, 7132.215456299907, 7459.992900958301, 8100.513969161869, 8205.491974842951, 8365.539895305574, 7194.352508274071, 11180.217384782987, 11212.775744485229, 12982.480700771863, 13138.277394743382, 11308.095352371625, 11406.429678515875, 11409.087273018305, 11590.536378544764, 11627.825582616437, 8657.437266577652, 11000.0, 11081.50133244022, 11340.659780206606, 11448.828267575826, 11359.886401135884, 11596.246243994114, 11805.527778888749, 11852.762944740884, 11857.466414011562, 8106.918930810616, 8258.504489730636, 8266.421350505407, 8278.875816862632, 8429.789255268668, 9634.181094607036, 10866.0, 11305.830412543653, 11513.654590362303, 11518.36648984314], "value": 9654.263469439358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.1456377146912, 1562.3750499800078, 1823.972640410394, 1881.9811801881986, 1945.7178709087175, 8033.558154301511, 8543.188397102282, 8562.785930351736, 9046.823912891323, 9069.365144439891, 8727.781805454852, 8836.072212417685, 8876.289896808255, 8886.688965886195, 8901.955490222539, 2370.170440345874, 2400.939976500593, 2401.4236583220077, 2402.0752010475917, 2408.9638655420094, 2343.753905839888, 2379.357573455166, 2391.8325717199805, 2396.940076498084, 2402.447437089462, 2363.3382652857226, 2378.988105059472, 2384.1059602649007, 2405.170216275391, 2408.301592538162, 2330.673705681206, 2379.9881000594974, 2384.3443053160345, 2388.6178211486167, 2391.7727815857465, 2334.101370972171, 2339.801116905065, 2356.02225076593, 2367.3726462487452, 2367.822413319008, 8922.643094276222, 8940.374173807835, 8960.686375976875, 8966.148215919477, 8979.236764874993, 5171.948280517222, 5315.654482458628, 5326.520613144797, 5331.813386531491, 5364.0, 3583.4087375583, 3596.28074385124, 3636.690881275095, 3675.3016926784094, 3687.483752274684, 1095.8137116690182, 1095.9616413425572, 1100.4387762241315, 1106.80630889594, 1121.1311233793795, 11571.0, 11705.941470292593, 11732.589359372381, 11741.765164696744, 11757.88242117585, 4565.315202719618, 4603.0, 4743.241081426955, 4751.976240118777, 4795.784189711471, 10024.298299118991, 10041.949790251001, 10053.095221430107, 10056.74858128538, 10064.245181611263, 5251.2123181523075, 5278.762455689426, 5337.679739215582, 5349.705766182898, 5354.946450535523, 4380.342948557742, 4620.792064357112, 4748.596369308648, 4789.401324834395, 4879.56083952446, 3623.166671665532, 3843.0008197868756, 3989.261986532501, 4038.212548553004, 4043.2924238258774, 1263.759885621729, 1270.866559011309, 1276.8786965238287, 1280.1998750780763, 1284.7494738525897, 773.7988123088038, 817.4441379861751, 893.5621545442816, 910.3263584947091, 945.669015844449, 4425.579569940851, 5627.493525582717, 5961.791337303173, 6040.214772079602, 6077.1491991121275, 973.3819024919227, 988.9011098890197, 1018.4500369800224, 1018.6689325969089, 1026.373911913732, 3308.5368048473233, 4105.281575724236, 4133.81397837098, 4198.223328684203, 4199.643030342394, 9855.901440985499, 10347.793044139225, 10477.580896764044, 10933.180011499011, 11065.336079835235, 8979.371443998987, 10011.449370284705, 10459.477026148663, 10658.893411065945, 10915.235933484739, 7921.089074756362, 8224.588770561448, 8226.753197403968, 8266.710665126811, 8286.337093032544, 5364.8122315718765, 5650.491455769001, 5935.436133567304, 5938.792142275, 6195.783147589813, 9775.80448391014, 9836.917939026844, 9925.702228933143, 10022.849657255001, 10087.04173103554, 7747.961260193663, 9010.0, 10191.643292485023, 10308.484575771032, 10345.120664743581, 7601.581912994839, 8156.469829461066, 8330.208630180123, 8431.283340915845, 8468.788280293042, 8515.574221289035, 8550.82898342042, 8589.613467394107, 8637.56812159377, 8657.783555410913, 7332.633368331455, 7507.324340809353, 7570.886436703344, 7590.127135379281, 7601.0, 7198.20819709842, 7230.060092188192, 7300.634968251672, 7352.816179595553, 7414.66634001482, 7136.464765142531, 7208.783736487913, 7213.170485394037, 7213.567185968858, 7243.203247642649, 4859.635527335393, 5014.129554856918, 5020.698758074527, 5032.0, 5061.569766569735, 4957.504249575014, 5027.924581131213, 5041.924371134362, 5045.5459008689395, 5136.8202112925865], "value": 4625.8861318534355, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [277.83191169342547, 306.53100755843553, 316.41621208869634, 317.0551755767813, 320.0558352859065, 4540.500544940062, 5460.945390546093, 5517.724113794315, 5526.281583394159, 5710.857228569288, 5328.040952628535, 5534.75093620787, 5628.831135065944, 5635.492805647491, 5684.442001099512, 4117.629413352797, 4260.637845783112, 4276.743395396286, 4282.828686852522, 4286.142771445708, 3511.227529943408, 4121.608447197512, 4204.642605378546, 4279.967015667564, 4281.272183728758, 4210.410542524034, 4221.831126754926, 4230.280852255124, 4247.320428731404, 4292.635126014293, 3668.449732540127, 4255.936160957588, 4261.637760790337, 4268.381084742695, 4280.850170244058, 2920.4889144399644, 3672.394054980925, 3675.0628589709722, 3676.191237927652, 3683.907902302437, 5262.947370526284, 5558.055130627803, 5561.944380556223, 5562.803997140634, 5575.916361254584, 4046.61557152073, 4946.505349465025, 4951.876203094916, 4982.427020892571, 4984.352034235526, 5365.841472858527, 5919.67229493455, 6045.737754882841, 6068.150458935753, 6121.387861213888, 3817.8854634361014, 4034.979825100885, 4037.212743515016, 4042.393640953851, 4067.3085575452246, 5232.895342093137, 6328.019157030668, 6332.778352757631, 6341.3341599132345, 6389.73164526591, 3430.8849623872343, 4109.671226301889, 4119.958800411958, 4136.420901073852, 4151.211269858717, 3131.4989601663624, 3394.3890099781784, 3744.0, 3885.3589157788647, 4095.3447448408706, 3440.9827950860085, 4186.832526698959, 4838.467768545457, 4848.927266091011, 4891.3396691446915, 5402.297701298806, 5654.802081927113, 5694.772209111672, 6004.609700369462, 6041.2750469943885, 1365.6654119740726, 1399.762040453105, 1403.2913378743874, 1405.7488834936914, 1407.5572538148276, 750.4784174998324, 836.9121242269596, 862.5040601654074, 868.522312727997, 868.8740132680726, 4231.196072746168, 4429.9778501107285, 4715.669903106818, 4773.880652983634, 4812.639052071038, 4374.156798081272, 4571.954280457219, 5173.301604283449, 5262.97368513155, 5287.947120528823, 4068.4914385701786, 4112.444819949268, 4125.608067233608, 4689.859304220879, 4754.690945088558, 2799.866054248033, 2966.569847372119, 3224.193951512122, 3278.950815737766, 3281.868725251011, 5937.851553711192, 6440.806775796734, 6500.577462465019, 6512.641804700787, 6525.869482610321, 5182.844514664566, 5368.3826359968325, 6045.395460454008, 6353.904691429632, 6507.609543427409, 6349.492040636738, 6455.935440645533, 6481.416672499403, 6498.740050398026, 6521.445677117308, 5939.3466718661775, 6230.034344676583, 6249.0, 6317.494600432046, 6357.396047375492, 6061.939380606137, 6129.08063790435, 6135.570510064253, 6141.539384546088, 6199.318075011655, 6237.425551777999, 6451.838564126207, 6483.578567393104, 6492.870142597216, 6498.415142636996, 3299.686529779667, 3984.0, 4053.189362127527, 4054.3513037914972, 4060.654844338146, 4594.494605593315, 6140.964409184426, 6153.600015998945, 6183.381661833961, 6203.0, 4599.333096700892, 5944.940550594439, 5968.432998865101, 6057.183409714504, 6060.90908636362, 5234.869128271824, 5969.940300596939, 6057.575969682256, 6082.2701275847185, 6087.208662873798, 5771.701367192348, 5831.591788574759, 5907.675077870758, 5914.166608351425, 5942.286925568959, 6071.332153463204, 6082.513398928164, 6099.939000610115, 6109.969450152721, 6128.233970753656, 4898.8775280618265, 5534.0, 5920.579061025409, 5958.731857066356, 6006.609570377911], "value": 4262.5981281384375, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.9198693946022, 735.9889601655976, 771.1324759645399, 782.6830133795813, 790.6679194738209, 15505.92247038766, 15553.844461555382, 16027.278772455238, 16167.676646467064, 16247.025178489284, 14738.926305368459, 14869.256537173153, 14902.105873647588, 14907.403703851833, 14926.62683432912, 719.8632259870634, 882.4352414454754, 889.5552223888039, 912.7672443526891, 912.8083102548472, 904.8371293167228, 908.9318301127408, 915.4187091197072, 916.0701887584107, 918.5820451694497, 954.1174413667364, 965.1120968708805, 966.2366730283068, 969.5976169889523, 971.0386717150006, 944.8960614332418, 953.6471505542925, 961.1733908838394, 961.427950369529, 964.0744884910495, 688.9321551595008, 702.3012102957539, 722.32823474169, 726.0162479839794, 726.4769366056431, 15569.143697096655, 15576.221188940508, 15586.844131558653, 15633.140177290245, 15920.771092047122, 15017.849821501755, 15026.09843409388, 15151.469698560497, 15172.0, 15195.62010949724, 12059.758804823854, 12272.938635306766, 12544.560940367044, 12580.0, 12624.68438289041, 3884.2814079395403, 3889.2221555688693, 4102.856400026015, 4120.381942708587, 4122.835086596532, 121424.0, 124077.75922240842, 124813.0, 128552.0, 133484.6651533482, 11664.825027624593, 11708.829117088393, 11779.0, 11828.116942361848, 11899.76200476003, 24610.5077898441, 25008.49983000366, 25025.124120655688, 25042.37394065163, 25069.62395564068, 8393.370497212734, 8403.15968403167, 8415.158484151536, 8468.0, 8693.869591956125, 4092.815823287959, 4580.1068791585985, 4651.232546629836, 4683.672142949961, 4776.307435421914, 3132.4988001920037, 3583.211693427494, 3656.945145822815, 3683.1344634010984, 3690.3357395669036, 532.5233915645475, 615.6552330694825, 616.7748771698298, 647.155462121926, 658.6212927566669, 577.1429427300455, 639.8336432527576, 640.6668532363238, 690.5062880040795, 704.3344039882262, 8543.572821359032, 9213.723588292361, 9279.860802087975, 9346.953265233631, 9389.342746007715, 520.8359366799446, 559.1249694228601, 589.0927970924813, 617.9011358182669, 661.272600139852, 3973.245083434196, 4605.171069207575, 4605.65457590682, 4609.262517997105, 4652.55800698933, 102149.48925255475, 102620.48689756653, 153850.0, 167041.0, 169384.0, 131980.0, 150628.70284728688, 152697.12862921195, 152881.23559382354, 156876.21561892118, 75945.24054759492, 79497.60251198823, 83990.58004709937, 84220.0, 118141.0, 8811.427257228259, 8856.822863542822, 8875.822483550422, 8881.777955551162, 9030.142136497023, 41386.79306603448, 66906.66546667235, 67682.9847552297, 69811.0, 71820.64089679727, 91994.0, 94272.0, 94583.05416945742, 96574.51712741391, 97551.0, 13760.65598360049, 13789.0, 13825.51610693621, 13877.097988630707, 13948.930255349063, 15191.088534687955, 15403.306851191948, 15602.141882196589, 15948.521544353687, 16153.838461615233, 13874.861251387762, 13977.790333144807, 14030.368633411725, 14082.718345633235, 14132.576022719335, 13235.139715918434, 13264.094218202752, 13376.464941402235, 13463.528776492776, 14004.159750415009, 13813.723725525233, 14100.294985250901, 14184.29078546048, 14272.785908211177, 14460.445554119024, 11254.493547790205, 11403.543858245577, 11508.769824603629, 11602.6519204424, 12009.699757506132, 9520.476373799507, 10589.576416943544, 10970.945145274223, 11569.6529104127, 11867.881321187024], "value": 8043.541190949227, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 106.0, 113.0, 116.0, 119.0, 151.0, 171.0, 172.0, 157.0], "value": 132.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 138.0, 152.0, 110.0, 131.0, 128.0, 110.0, 155.0, 110.0], "value": 128.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 200.0, 201.0, 207.0, 233.0, 255.0, 194.0, 203.0, 221.0, 229.0], "value": 214.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 83.0, 79.0, 167.0, 61.0, 59.0, 58.0, 61.0, 145.0, 79.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 122.0, 70.0, 74.0, 75.0, 109.0, 67.0, 72.0, 109.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 78.0, 86.0, 135.0, 122.0, 90.0, 74.0], "value": 93.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 101.0, 143.0, 120.0, 97.0, 151.0, 154.0, 119.0, 95.0, 96.0], "value": 117.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 137.0, 90.0, 90.0, 89.0, 149.0, 153.0, 91.0, 138.0, 143.0], "value": 118.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 59.0, 55.0, 61.0, 87.0, 88.0, 87.0, 85.0], "value": 69.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 65.0, 75.0, 73.0, 67.0, 75.0, 74.0, 71.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 89.0, 87.0, 85.0, 82.0, 88.0, 84.0, 87.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 135.0, 130.0, 156.0, 147.0, 149.0, 134.0, 175.0, 136.0], "value": 143.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 228.0, 226.0, 212.0, 218.0, 184.0, 167.0, 209.0, 162.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 70.0, 69.0, 65.0, 67.0, 68.0, 70.0], "value": 67.7, "unit": "score"}]}]} 15:51:33 INFO - Return code: 0 15:51:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:51:33 ERROR - # TBPL SUCCESS # 15:51:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:51:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:51:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:51:33 INFO - 2016-07-13 15:51:33.191 screenresolution[1676:10299] starting screenresolution argv=screenresolution get 15:51:33 INFO - 2016-07-13 15:51:33.193 screenresolution[1676:10299] Display 0: 1600x1200x32@60 15:51:33 INFO - 2016-07-13 15:51:33.199 screenresolution[1677:10302] starting screenresolution argv=screenresolution list 15:51:33 INFO - Available Modes on Display 0 15:51:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:51:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:51:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:51:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:51:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:51:33 INFO - Intel Iris: 15:51:33 INFO - Chipset Model: Intel Iris 15:51:33 INFO - Type: GPU 15:51:33 INFO - Bus: Built-In 15:51:33 INFO - VRAM (Dynamic, Max): 1536 MB 15:51:33 INFO - Vendor: Intel (0x8086) 15:51:33 INFO - Device ID: 0x0a2e 15:51:33 INFO - Revision ID: 0x0009 15:51:33 INFO - Displays: 15:51:33 INFO - Display: 15:51:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:51:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:51:33 INFO - Display Serial Number: 1600x1200 60 15:51:33 INFO - Main Display: Yes 15:51:33 INFO - Mirror: Off 15:51:33 INFO - Online: Yes 15:51:33 INFO - Rotation: Supported 15:51:33 INFO - Return code: 0 15:51:33 INFO - Running post-action listener: _resource_record_post_action 15:51:33 INFO - ##### 15:51:33 INFO - ##### Finished run-tests step (success) 15:51:33 INFO - ##### 15:51:33 INFO - Running post-run listener: _resource_record_post_run 15:51:33 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 37033472; Write bytes: 706042368; Read time: 236; Write time: 1963 15:51:33 INFO - TinderboxPrint: CPU usage
54.2% 15:51:33 INFO - TinderboxPrint: I/O read bytes / time
37,033,472 / 236 15:51:33 INFO - TinderboxPrint: I/O write bytes / time
706,042,368 / 1,963 15:51:33 INFO - TinderboxPrint: CPU idle
2,211.8 (45.8%) 15:51:33 INFO - TinderboxPrint: CPU system
973.5 (20.1%) 15:51:33 INFO - TinderboxPrint: CPU user
1,648.3 (34.1%) 15:51:33 INFO - TinderboxPrint: Swap in / out
444,227,584 / 0 15:51:33 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 407962112; Write bytes: 409310720; Read time: 30829; Write time: 845 15:51:33 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34436608; Write bytes: 295121920; Read time: 214; Write time: 1111 15:51:33 INFO - Running post-run listener: _upload_blobber_files 15:51:33 INFO - Blob upload gear active. 15:51:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:51:33 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 15:51:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:51:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:51:34 INFO - (blobuploader) - INFO - Open directory for files ... 15:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:35 INFO - (blobuploader) - INFO - Done attempting. 15:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:36 INFO - (blobuploader) - INFO - Done attempting. 15:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:51:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:51:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:51:38 INFO - (blobuploader) - INFO - Done attempting. 15:51:38 INFO - (blobuploader) - INFO - Iteration through files over. 15:51:38 INFO - Return code: 0 15:51:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:51:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:51:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ed1f06328e11660dcd329cf131eb2e67b97662ad0cceb6722ca126661381d444d8f4800f1b9342cc3ea4f17c1afd461cfd31a6f28cb830fe51e6f5105ec7f8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7debd6d469d8b35be4477d46cf7d49bce4967c82d9c74b863d322fe82af1220da034b9e5e4cab45580a86594b30e184c38df3c71c2d0124604ebb6e4a4ee31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5528614391bc154082fac2dfd5acd0b5d5acc18f5f473809bf495f2bb8d9a44e6262fa234323ec83c0a3a7ca8a16755c19a21bcef3fcc5cfc26dcd95bf40a7ba"} 15:51:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:51:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:51:38 INFO - Contents: 15:51:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ed1f06328e11660dcd329cf131eb2e67b97662ad0cceb6722ca126661381d444d8f4800f1b9342cc3ea4f17c1afd461cfd31a6f28cb830fe51e6f5105ec7f8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7debd6d469d8b35be4477d46cf7d49bce4967c82d9c74b863d322fe82af1220da034b9e5e4cab45580a86594b30e184c38df3c71c2d0124604ebb6e4a4ee31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5528614391bc154082fac2dfd5acd0b5d5acc18f5f473809bf495f2bb8d9a44e6262fa234323ec83c0a3a7ca8a16755c19a21bcef3fcc5cfc26dcd95bf40a7ba"} 15:51:38 INFO - Running post-run listener: copy_logs_to_upload_dir 15:51:38 INFO - Copying logs to upload dir... 15:51:38 INFO - mkdir: /builds/slave/test/build/upload/logs 15:51:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.444976 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-13 15:51:38.253514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:51:38.259216) ========= 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.s139zN1pHh/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.uDJusuSp7k/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ed1f06328e11660dcd329cf131eb2e67b97662ad0cceb6722ca126661381d444d8f4800f1b9342cc3ea4f17c1afd461cfd31a6f28cb830fe51e6f5105ec7f8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7debd6d469d8b35be4477d46cf7d49bce4967c82d9c74b863d322fe82af1220da034b9e5e4cab45580a86594b30e184c38df3c71c2d0124604ebb6e4a4ee31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5528614391bc154082fac2dfd5acd0b5d5acc18f5f473809bf495f2bb8d9a44e6262fa234323ec83c0a3a7ca8a16755c19a21bcef3fcc5cfc26dcd95bf40a7ba"} build_url:https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010334 build_url: 'https://queue.taskcluster.net/v1/task/AP3KEPuzT26gqxI-1gLeNw/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/ed1f06328e11660dcd329cf131eb2e67b97662ad0cceb6722ca126661381d444d8f4800f1b9342cc3ea4f17c1afd461cfd31a6f28cb830fe51e6f5105ec7f8bb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c7debd6d469d8b35be4477d46cf7d49bce4967c82d9c74b863d322fe82af1220da034b9e5e4cab45580a86594b30e184c38df3c71c2d0124604ebb6e4a4ee31e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5528614391bc154082fac2dfd5acd0b5d5acc18f5f473809bf495f2bb8d9a44e6262fa234323ec83c0a3a7ca8a16755c19a21bcef3fcc5cfc26dcd95bf40a7ba"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 15:51:38.290815) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:51:38.291142) ========= 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.s139zN1pHh/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.uDJusuSp7k/Listeners TMPDIR=/var/folders/yy/_44wh5bs15g2887w0j7qn4n400000w/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.005129 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 15:51:38.339749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:51:38.340096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 15:51:38.340441) ========= ========= Total master_lag: 0.49 =========