builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0317 starttime: 1467931144.09 results: success (0) buildid: 20160706073358 builduid: 1f733ccafb1b4c028e2bfb2937406a20 revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.090077) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.090564) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.090842) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.117285) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.117814) ========= 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.dMWNwrPpGa/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.6gpcLEKInC/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-07 15:39:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2016-07-07 15:39:04 (18.3 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161117 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.319318) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.319632) ========= 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.dMWNwrPpGa/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.6gpcLEKInC/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.026711 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:04.376545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 15:39:04.376950) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dMWNwrPpGa/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.6gpcLEKInC/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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-07 15:39:04,462 truncating revision to first 12 chars 2016-07-07 15:39:04,462 Setting DEBUG logging. 2016-07-07 15:39:04,462 attempt 1/10 2016-07-07 15:39:04,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/01a1714a1d04?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 15:39:05,883 unpacking tar archive at: mozilla-beta-01a1714a1d04/testing/mozharness/ program finished with exit code 0 elapsedTime=1.688791 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 15:39:06.088169) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:06.088472) ========= script_repo_revision: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:06.088860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:06.089143) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 15:39:06.107896) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 15:39:06.108300) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dMWNwrPpGa/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.6gpcLEKInC/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:06 INFO - MultiFileLogger online at 20160707 15:39:06 in /builds/slave/test 15:39:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:39:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:39:06 INFO - {'append_to_log': False, 15:39:06 INFO - 'base_work_dir': '/builds/slave/test', 15:39:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:39:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:39:06 INFO - 'branch': 'Mozilla-Beta', 15:39:06 INFO - 'buildbot_json_path': 'buildprops.json', 15:39:06 INFO - 'config_files': ('talos/mac_config.py',), 15:39:06 INFO - 'default_actions': ('clobber', 15:39:06 INFO - 'read-buildbot-config', 15:39:06 INFO - 'download-and-extract', 15:39:06 INFO - 'populate-webroot', 15:39:06 INFO - 'create-virtualenv', 15:39:06 INFO - 'install', 15:39:06 INFO - 'run-tests'), 15:39:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:39:06 INFO - 'download_minidump_stackwalk': True, 15:39:06 INFO - 'download_symbols': 'ondemand', 15:39:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:39:06 INFO - 'tooltool.py': '/tools/tooltool.py', 15:39:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:39:06 INFO - '/tools/misc-python/virtualenv.py')}, 15:39:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:39:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:39:06 INFO - 'installer_path': 'installer.exe', 15:39:06 INFO - 'log_level': 'info', 15:39:06 INFO - 'log_name': 'talos', 15:39:06 INFO - 'log_to_console': True, 15:39:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:39:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:39:06 INFO - 'opt_config_files': (), 15:39:06 INFO - 'pip_index': False, 15:39:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:39:06 INFO - 'cmd': ('bash', 15:39:06 INFO - '-c', 15:39:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:39:06 INFO - 'enabled': True, 15:39:06 INFO - 'halt_on_failure': False, 15:39:06 INFO - 'name': 'check_screen_resolution'},), 15:39:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:39:06 INFO - 'cmd': ('bash', 15:39:06 INFO - '-c', 15:39:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:39:06 INFO - 'enabled': True, 15:39:06 INFO - 'halt_on_failure': False, 15:39:06 INFO - 'name': 'check_screen_resolution'},), 15:39:06 INFO - 'run_cmd_checks_enabled': True, 15:39:06 INFO - 'sps_profile': False, 15:39:06 INFO - 'sps_profile_interval': 0, 15:39:06 INFO - 'suite': 'dromaeojs-e10s', 15:39:06 INFO - 'system_bits': '32', 15:39:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:39:06 INFO - 'title': 't-yosemite-r7-0317', 15:39:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:39:06 INFO - 'use_talos_json': True, 15:39:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:39:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:39:06 INFO - 'work_dir': 'build'} 15:39:06 INFO - ##### 15:39:06 INFO - ##### Running clobber step. 15:39:06 INFO - ##### 15:39:06 INFO - Running pre-action listener: _resource_record_pre_action 15:39:06 INFO - Running main action method: clobber 15:39:06 INFO - rmtree: /builds/slave/test/build 15:39:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:39:08 INFO - Running post-action listener: _resource_record_post_action 15:39:08 INFO - ##### 15:39:08 INFO - ##### Running read-buildbot-config step. 15:39:08 INFO - ##### 15:39:08 INFO - Running pre-action listener: _resource_record_pre_action 15:39:08 INFO - Running main action method: read_buildbot_config 15:39:08 INFO - Using buildbot properties: 15:39:08 INFO - { 15:39:08 INFO - "project": "", 15:39:08 INFO - "product": "firefox", 15:39:08 INFO - "script_repo_revision": "production", 15:39:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:39:08 INFO - "repository": "", 15:39:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:39:08 INFO - "buildid": "20160706073358", 15:39:08 INFO - "pgo_build": "False", 15:39:08 INFO - "basedir": "/builds/slave/test", 15:39:08 INFO - "buildnumber": 30, 15:39:08 INFO - "slavename": "t-yosemite-r7-0317", 15:39:08 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:39:08 INFO - "platform": "yosemite_r7", 15:39:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:39:08 INFO - "branch": "mozilla-beta", 15:39:08 INFO - "repo_path": "releases/mozilla-beta", 15:39:08 INFO - "revision": "01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d", 15:39:08 INFO - "stage_platform": "macosx64", 15:39:08 INFO - "builduid": "1f733ccafb1b4c028e2bfb2937406a20", 15:39:08 INFO - "slavebuilddir": "test" 15:39:08 INFO - } 15:39:08 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg. 15:39:08 INFO - Running post-action listener: _resource_record_post_action 15:39:08 INFO - ##### 15:39:08 INFO - ##### Running download-and-extract step. 15:39:08 INFO - ##### 15:39:08 INFO - Running pre-action listener: _resource_record_pre_action 15:39:08 INFO - Running main action method: download_and_extract 15:39:08 INFO - mkdir: /builds/slave/test/build/tests 15:39:08 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:39:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.test_packages.json 15:39:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 15:39:08 INFO - Downloaded 1165 bytes. 15:39:08 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 15:39:08 INFO - Using the following test package requirements: 15:39:08 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:39:08 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 15:39:08 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 15:39:08 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:39:08 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 15:39:08 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 15:39:08 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 15:39:08 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 15:39:08 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 15:39:08 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 15:39:08 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 15:39:08 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 15:39:08 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:39:08 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip 15:39:08 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:39:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 15:39:11 INFO - Downloaded 18351403 bytes. 15:39:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:39:14 INFO - Return code: 0 15:39:14 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:39:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:14 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip 15:39:14 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 15:39:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 15:39:14 INFO - Downloaded 18351403 bytes. 15:39:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 15:39:18 INFO - Return code: 0 15:39: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:39:18 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.talos.tests.zip 15:39:18 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 15:39:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 15:39:20 INFO - Downloaded 10840145 bytes. 15:39:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:39:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 15:39:20 INFO - Return code: 0 15:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:20 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg 15:39:20 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 15:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 15:39:24 INFO - Downloaded 86190842 bytes. 15:39:24 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg 15:39:24 INFO - mkdir: /builds/slave/test/properties 15:39:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:39:24 INFO - Writing to file /builds/slave/test/properties/build_url 15:39:24 INFO - Contents: 15:39:24 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - Running post-action listener: set_extra_try_arguments 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running populate-webroot step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: populate_webroot 15:39:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:39:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:39:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:39:24 INFO - '--tppagecycles', 15:39:24 INFO - '7'], 15:39:24 INFO - 'tests': ['tsvgm']}}, 15:39:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:39:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:39:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:39:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:39:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:39:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['damp', 'tps']}, 15:39:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['damp', 'tps']}, 15:39:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['dromaeo_dom']}, 15:39:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:39:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['a11yr', 15:39:24 INFO - 'ts_paint', 15:39:24 INFO - 'tpaint', 15:39:24 INFO - 'sessionrestore', 15:39:24 INFO - 'sessionrestore_no_auto_restore', 15:39:24 INFO - 'tabpaint']}, 15:39:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tsvgx', 15:39:24 INFO - 'tsvgr_opacity', 15:39:24 INFO - 'tart', 15:39:24 INFO - 'tscrollx', 15:39:24 INFO - 'cart']}, 15:39:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:39:24 INFO - 'tsvgr_opacity', 15:39:24 INFO - 'tart', 15:39:24 INFO - 'tscrollx', 15:39:24 INFO - 'cart']}, 15:39:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s'], 15:39:24 INFO - 'tests': ['tp5o']}, 15:39:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'tests': ['tp5o']}, 15:39:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--disable-e10s', 15:39:24 INFO - '--xperf_path', 15:39:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:24 INFO - 'tests': ['tp5n']}, 15:39:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:39:24 INFO - 'talos_options': ['--xperf_path', 15:39:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:39:24 INFO - 'tests': ['tp5n']}}, 15:39:24 INFO - 'talos.zip': {'path': '', 15:39:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:39:24 INFO - Running post-action listener: _resource_record_post_action 15:39:24 INFO - ##### 15:39:24 INFO - ##### Running create-virtualenv step. 15:39:24 INFO - ##### 15:39:24 INFO - Running pre-action listener: _resource_record_pre_action 15:39:24 INFO - Running main action method: create_virtualenv 15:39:24 INFO - Creating virtualenv /builds/slave/test/build/venv 15:39:24 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:39:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:39:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:39:24 INFO - Using real prefix '/tools/python27' 15:39:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:39:25 INFO - Installing distribute.............................................................................................................................................................................................done. 15:39:28 INFO - Installing pip.................done. 15:39:28 INFO - Return code: 0 15:39:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:39:28 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:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:28 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:39:28 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:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:28 INFO - 'HOME': '/Users/cltbld', 15:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:28 INFO - 'LOGNAME': 'cltbld', 15:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:28 INFO - 'MOZ_NO_REMOTE': '1', 15:39:28 INFO - 'NO_EM_RESTART': '1', 15:39:28 INFO - 'PAGER': '/bin/cat', 15:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:28 INFO - 'PWD': '/builds/slave/test', 15:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:28 INFO - 'SHELL': '/bin/bash', 15:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:28 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:28 INFO - 'USER': 'cltbld', 15:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:28 INFO - 'XPC_FLAGS': '0x0', 15:39:28 INFO - 'XPC_SERVICE_NAME': '0', 15:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:28 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:39:28 INFO - Cleaning up... 15:39:28 INFO - Return code: 0 15:39:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:39:28 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:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:28 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:28 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>=0.7.1'] in /builds/slave/test/build 15:39:28 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>=0.7.1 15:39:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:28 INFO - 'HOME': '/Users/cltbld', 15:39:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:28 INFO - 'LOGNAME': 'cltbld', 15:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:28 INFO - 'MOZ_NO_REMOTE': '1', 15:39:28 INFO - 'NO_EM_RESTART': '1', 15:39:28 INFO - 'PAGER': '/bin/cat', 15:39:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:28 INFO - 'PWD': '/builds/slave/test', 15:39:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:28 INFO - 'SHELL': '/bin/bash', 15:39:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:28 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:28 INFO - 'USER': 'cltbld', 15:39:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:28 INFO - 'XPC_FLAGS': '0x0', 15:39:28 INFO - 'XPC_SERVICE_NAME': '0', 15:39:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:28 INFO - Downloading/unpacking psutil>=0.7.1 15:39:28 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:39:28 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:39:28 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:39:28 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:39:28 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:39:28 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:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:39:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:32 INFO - Installing collected packages: psutil 15:39:32 INFO - Running setup.py install for psutil 15:39:32 INFO - building 'psutil._psutil_osx' extension 15:39:32 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:39:32 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:39:32 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:39:32 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:39:32 INFO - building 'psutil._psutil_posix' extension 15:39:32 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:39:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:39:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:39:32 INFO - ^ 15:39:32 INFO - 1 warning generated. 15:39:32 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:39:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:39:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:39:33 INFO - Successfully installed psutil 15:39:33 INFO - Cleaning up... 15:39:33 INFO - Return code: 0 15:39:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:39:33 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:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:33 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:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:33 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:33 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.0.0'] in /builds/slave/test/build 15:39:33 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.0.0 15:39:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:33 INFO - 'HOME': '/Users/cltbld', 15:39:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:33 INFO - 'LOGNAME': 'cltbld', 15:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:33 INFO - 'MOZ_NO_REMOTE': '1', 15:39:33 INFO - 'NO_EM_RESTART': '1', 15:39:33 INFO - 'PAGER': '/bin/cat', 15:39:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:33 INFO - 'PWD': '/builds/slave/test', 15:39:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:33 INFO - 'SHELL': '/bin/bash', 15:39:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:33 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:33 INFO - 'USER': 'cltbld', 15:39:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:33 INFO - 'XPC_FLAGS': '0x0', 15:39:33 INFO - 'XPC_SERVICE_NAME': '0', 15:39:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:33 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:39:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:39:36 INFO - Installing collected packages: mozsystemmonitor 15:39:36 INFO - Running setup.py install for mozsystemmonitor 15:39:36 INFO - Successfully installed mozsystemmonitor 15:39:36 INFO - Cleaning up... 15:39:36 INFO - Return code: 0 15:39:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:39:36 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:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:36 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:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:36 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 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:36 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:39:36 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:39:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:36 INFO - 'HOME': '/Users/cltbld', 15:39:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:36 INFO - 'LOGNAME': 'cltbld', 15:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:36 INFO - 'MOZ_NO_REMOTE': '1', 15:39:36 INFO - 'NO_EM_RESTART': '1', 15:39:36 INFO - 'PAGER': '/bin/cat', 15:39:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:36 INFO - 'PWD': '/builds/slave/test', 15:39:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:36 INFO - 'SHELL': '/bin/bash', 15:39:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:36 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:36 INFO - 'USER': 'cltbld', 15:39:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:36 INFO - 'XPC_FLAGS': '0x0', 15:39:36 INFO - 'XPC_SERVICE_NAME': '0', 15:39:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:36 INFO - Downloading/unpacking blobuploader==1.2.4 15:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:36 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:39:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:39:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:39:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:39 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:39:40 INFO - Downloading docopt-0.6.1.tar.gz 15:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:39:40 INFO - Installing collected packages: blobuploader, requests, docopt 15:39:40 INFO - Running setup.py install for blobuploader 15:39:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:39:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:39:40 INFO - Running setup.py install for requests 15:39:41 INFO - Running setup.py install for docopt 15:39:41 INFO - Successfully installed blobuploader requests docopt 15:39:41 INFO - Cleaning up... 15:39:41 INFO - Return code: 0 15:39:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:41 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 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:41 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:39:41 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:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:41 INFO - 'HOME': '/Users/cltbld', 15:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:41 INFO - 'LOGNAME': 'cltbld', 15:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:41 INFO - 'MOZ_NO_REMOTE': '1', 15:39:41 INFO - 'NO_EM_RESTART': '1', 15:39:41 INFO - 'PAGER': '/bin/cat', 15:39:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:41 INFO - 'PWD': '/builds/slave/test', 15:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:41 INFO - 'SHELL': '/bin/bash', 15:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:41 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:41 INFO - 'USER': 'cltbld', 15:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:41 INFO - 'XPC_FLAGS': '0x0', 15:39:41 INFO - 'XPC_SERVICE_NAME': '0', 15:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-d5XxSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-wQ2YJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-mg6n5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:41 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-3MBZLi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-m03eRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-FsCPJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-To16nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-STXG2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tWtwlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-gB0bOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-1UDLCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-gVFHF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-qRSj_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:42 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-dreGpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:43 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-rlWyiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:43 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-G9PrgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:43 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-MM71v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:39:43 INFO - Running setup.py install for manifestparser 15:39:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:39:43 INFO - Running setup.py install for mozcrash 15:39:43 INFO - Running setup.py install for mozdebug 15:39:43 INFO - Running setup.py install for mozdevice 15:39:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:39:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozfile 15:39:44 INFO - Running setup.py install for mozhttpd 15:39:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozinfo 15:39:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozInstall 15:39:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for mozleak 15:39:44 INFO - Running setup.py install for mozlog 15:39:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:39:44 INFO - Running setup.py install for moznetwork 15:39:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozprocess 15:39:45 INFO - Running setup.py install for mozprofile 15:39:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozrunner 15:39:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Running setup.py install for mozscreenshot 15:39:45 INFO - Running setup.py install for moztest 15:39:45 INFO - Running setup.py install for mozversion 15:39:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:39:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:39:45 INFO - Cleaning up... 15:39:46 INFO - Return code: 0 15:39:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:46 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:39:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:46 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:39:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:46 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 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:46 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:39:46 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:39:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:46 INFO - 'HOME': '/Users/cltbld', 15:39:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:46 INFO - 'LOGNAME': 'cltbld', 15:39:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:46 INFO - 'MOZ_NO_REMOTE': '1', 15:39:46 INFO - 'NO_EM_RESTART': '1', 15:39:46 INFO - 'PAGER': '/bin/cat', 15:39:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:46 INFO - 'PWD': '/builds/slave/test', 15:39:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:46 INFO - 'SHELL': '/bin/bash', 15:39:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:46 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:46 INFO - 'USER': 'cltbld', 15:39:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:46 INFO - 'XPC_FLAGS': '0x0', 15:39:46 INFO - 'XPC_SERVICE_NAME': '0', 15:39:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-9Qh4XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-VRDwIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-5rkA1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-_2wP_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-tIyZlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-bY24_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:39:46 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:39:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:39:46 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-7o697q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-fd7TFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-U7G7B_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-NZaxep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-RB0goH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-CW_TTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-OcFb5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-72oxJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:39:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-UoUjK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-QaG12P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:39:47 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:39:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:39:47 INFO - Running setup.py (path:/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/pip-x05_kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 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:39:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:50 INFO - Downloading blessings-1.6.tar.gz 15:39:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:39:50 INFO - Installing collected packages: blessings 15:39:50 INFO - Running setup.py install for blessings 15:39:50 INFO - Successfully installed blessings 15:39:50 INFO - Cleaning up... 15:39:50 INFO - Return code: 0 15:39:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:39:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:51 INFO - Reading from file tmpfile_stdout 15:39:51 INFO - Current package versions: 15:39:51 INFO - blessings == 1.6 15:39:51 INFO - blobuploader == 1.2.4 15:39:51 INFO - docopt == 0.6.1 15:39:51 INFO - manifestparser == 1.1 15:39:51 INFO - mozInstall == 1.12 15:39:51 INFO - mozcrash == 0.17 15:39:51 INFO - mozdebug == 0.1 15:39:51 INFO - mozdevice == 0.48 15:39:51 INFO - mozfile == 1.2 15:39:51 INFO - mozhttpd == 0.7 15:39:51 INFO - mozinfo == 0.9 15:39:51 INFO - mozleak == 0.1 15:39:51 INFO - mozlog == 3.1 15:39:51 INFO - moznetwork == 0.27 15:39:51 INFO - mozprocess == 0.22 15:39:51 INFO - mozprofile == 0.28 15:39:51 INFO - mozrunner == 6.11 15:39:51 INFO - mozscreenshot == 0.1 15:39:51 INFO - mozsystemmonitor == 0.0 15:39:51 INFO - moztest == 0.7 15:39:51 INFO - mozversion == 1.4 15:39:51 INFO - psutil == 3.1.1 15:39:51 INFO - requests == 1.2.3 15:39:51 INFO - wsgiref == 0.1.2 15:39:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 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 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:51 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:39:51 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:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:51 INFO - 'HOME': '/Users/cltbld', 15:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:51 INFO - 'LOGNAME': 'cltbld', 15:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:51 INFO - 'MOZ_NO_REMOTE': '1', 15:39:51 INFO - 'NO_EM_RESTART': '1', 15:39:51 INFO - 'PAGER': '/bin/cat', 15:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:51 INFO - 'PWD': '/builds/slave/test', 15:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:51 INFO - 'SHELL': '/bin/bash', 15:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:51 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:51 INFO - 'USER': 'cltbld', 15:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:51 INFO - 'XPC_FLAGS': '0x0', 15:39:51 INFO - 'XPC_SERVICE_NAME': '0', 15:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 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:39:51 INFO - Cleaning up... 15:39:51 INFO - Return code: 0 15:39:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:39:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:51 INFO - 'HOME': '/Users/cltbld', 15:39:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:51 INFO - 'LOGNAME': 'cltbld', 15:39:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:51 INFO - 'MOZ_NO_REMOTE': '1', 15:39:51 INFO - 'NO_EM_RESTART': '1', 15:39:51 INFO - 'PAGER': '/bin/cat', 15:39:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:51 INFO - 'PWD': '/builds/slave/test', 15:39:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:51 INFO - 'SHELL': '/bin/bash', 15:39:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:51 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:51 INFO - 'USER': 'cltbld', 15:39:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:51 INFO - 'XPC_FLAGS': '0x0', 15:39:51 INFO - 'XPC_SERVICE_NAME': '0', 15:39:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:51 INFO - Downloading/unpacking jsonschema 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:39:54 INFO - Downloading/unpacking functools32 (from jsonschema) 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:39:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:39:54 INFO - warning: no files found matching '*.txt' 15:39:54 INFO - no previously-included directories found matching 'build' 15:39:54 INFO - no previously-included directories found matching 'dist' 15:39:54 INFO - no previously-included directories found matching '.git*' 15:39:54 INFO - Installing collected packages: jsonschema, functools32 15:39:54 INFO - Running setup.py install for functools32 15:39:54 INFO - warning: no files found matching '*.txt' 15:39:54 INFO - no previously-included directories found matching 'build' 15:39:54 INFO - no previously-included directories found matching 'dist' 15:39:54 INFO - no previously-included directories found matching '.git*' 15:39:54 INFO - Successfully installed jsonschema functools32 15:39:54 INFO - Cleaning up... 15:39:54 INFO - Return code: 0 15:39:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:39:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:39:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:39:54 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c959a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c969420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc2f1e97130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, '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.dMWNwrPpGa/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.6gpcLEKInC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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:39:54 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', 'flake8'] in /builds/slave/test/build 15:39:54 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 flake8 15:39:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:39:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:39:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:39:54 INFO - 'HOME': '/Users/cltbld', 15:39:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:39:54 INFO - 'LOGNAME': 'cltbld', 15:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:39:54 INFO - 'MOZ_NO_REMOTE': '1', 15:39:54 INFO - 'NO_EM_RESTART': '1', 15:39:54 INFO - 'PAGER': '/bin/cat', 15:39:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:39:54 INFO - 'PWD': '/builds/slave/test', 15:39:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:39:54 INFO - 'SHELL': '/bin/bash', 15:39:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:39:54 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:39:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:39:54 INFO - 'USER': 'cltbld', 15:39:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:39:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:39:54 INFO - 'XPC_FLAGS': '0x0', 15:39:54 INFO - 'XPC_SERVICE_NAME': '0', 15:39:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:39:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:39:55 INFO - Downloading/unpacking flake8 15:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:39:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:39:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:39:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:39:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:39:57 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:39:57 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:39:57 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:39:57 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:39:57 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:39:57 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:39:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:39:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:39:57 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:39:57 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:39:57 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:39:57 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:39:57 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:39:57 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:39:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:39: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:39: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:39: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:39: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:39: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:39: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:39:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:39:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:58 INFO - no previously-included directories found matching 'docs/_build' 15:39:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:39:58 INFO - Running setup.py install for pep8 15:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:39:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:39:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:39:59 INFO - no previously-included directories found matching 'docs/_build' 15:39:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:39:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:39:59 INFO - Cleaning up... 15:39:59 INFO - Return code: 0 15:39:59 INFO - Running post-action listener: _resource_record_post_action 15:39:59 INFO - Running post-action listener: _start_resource_monitoring 15:39:59 INFO - Starting resource monitoring. 15:39:59 INFO - ##### 15:39:59 INFO - ##### Running install step. 15:39:59 INFO - ##### 15:39:59 INFO - Running pre-action listener: _resource_record_pre_action 15:39:59 INFO - Running main action method: install 15:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:39:59 INFO - Reading from file tmpfile_stdout 15:39:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:39:59 INFO - Reading from file tmpfile_stdout 15:39:59 INFO - Output received: 15:39:59 INFO - Usage: mozinstall [options] installer 15:39:59 INFO - Options: 15:39:59 INFO - -h, --help show this help message and exit 15:39:59 INFO - -d DEST, --destination=DEST 15:39:59 INFO - Directory to install application into. [default: 15:39:59 INFO - "/builds/slave/test"] 15:39:59 INFO - --app=APP Application being installed. [default: firefox] 15:39:59 INFO - mkdir: /builds/slave/test/build/application 15:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:40:21 INFO - Reading from file tmpfile_stdout 15:40:21 INFO - Output received: 15:40:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:40:21 INFO - Running post-action listener: _resource_record_post_action 15:40:21 INFO - ##### 15:40:21 INFO - ##### Running run-tests step. 15:40:21 INFO - ##### 15:40:21 INFO - Running pre-action listener: _resource_record_pre_action 15:40:21 INFO - Running main action method: run_tests 15:40:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:40:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:40:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:40:21 INFO - 2016-07-07 15:40:21.124 screenresolution[1642:7834] starting screenresolution argv=screenresolution get 15:40:21 INFO - 2016-07-07 15:40:21.126 screenresolution[1642:7834] Display 0: 1600x1200x32@60 15:40:21 INFO - 2016-07-07 15:40:21.132 screenresolution[1643:7836] starting screenresolution argv=screenresolution list 15:40:21 INFO - Available Modes on Display 0 15:40:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:40:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:40:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:40:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:40:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:40:21 INFO - Intel Iris: 15:40:21 INFO - Chipset Model: Intel Iris 15:40:21 INFO - Type: GPU 15:40:21 INFO - Bus: Built-In 15:40:21 INFO - VRAM (Dynamic, Max): 1536 MB 15:40:21 INFO - Vendor: Intel (0x8086) 15:40:21 INFO - Device ID: 0x0a2e 15:40:21 INFO - Revision ID: 0x0009 15:40:21 INFO - Displays: 15:40:21 INFO - Display: 15:40:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:40:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:40:21 INFO - Display Serial Number: 1600x1200 60 15:40:21 INFO - Main Display: Yes 15:40:21 INFO - Mirror: Off 15:40:21 INFO - Online: Yes 15:40:21 INFO - Rotation: Supported 15:40:21 INFO - Return code: 0 15:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:40:21 INFO - Python 2.7.3 15:40:21 INFO - Return code: 0 15:40:21 INFO - grabbing minidump binary from tooltool 15:40:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:40:21 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f8e00>, '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 0x10c661db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c7f3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:40:21 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:40:21 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:40:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:40:21 INFO - Return code: 0 15:40:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:40:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:40:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:40:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:40:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:40:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:40:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:40:22 INFO - Return code: 0 15:40:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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:40:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0317 --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:40:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dMWNwrPpGa/Render', 15:40:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:40:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:40:22 INFO - 'HOME': '/Users/cltbld', 15:40:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:40:22 INFO - 'LOGNAME': 'cltbld', 15:40:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:40:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:40:22 INFO - 'MOZ_NO_REMOTE': '1', 15:40:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:40:22 INFO - 'NO_EM_RESTART': '1', 15:40:22 INFO - 'PAGER': '/bin/cat', 15:40:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:40:22 INFO - 'PWD': '/builds/slave/test', 15:40:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:40:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:40:22 INFO - 'SHELL': '/bin/bash', 15:40:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6gpcLEKInC/Listeners', 15:40:22 INFO - 'TMPDIR': '/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/', 15:40:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:40:22 INFO - 'USER': 'cltbld', 15:40:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:40:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:40:22 INFO - 'XPC_FLAGS': '0x0', 15:40:22 INFO - 'XPC_SERVICE_NAME': '0', 15:40:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:40:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0317', '--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:40:22 INFO - mozversion application_buildid: 20160706073358 15:40:22 INFO - mozversion application_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 15:40:22 INFO - mozversion application_display_name: Firefox 15:40:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:40:22 INFO - mozversion application_name: Firefox 15:40:22 INFO - mozversion application_remotingname: firefox 15:40:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:40:22 INFO - mozversion application_vendor: Mozilla 15:40:22 INFO - mozversion application_version: 48.0 15:40:22 INFO - mozversion platform_buildid: 20160706073358 15:40:22 INFO - mozversion platform_changeset: 01a1714a1d049ff43ad0fe73d0c81ba5c04fad8d 15:40:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:40:22 INFO - mozversion platform_version: 48.0 15:40:22 INFO - using testdate: 1467931222 15:40:22 INFO - actual date: 1467931222 15:40:22 INFO - starting webserver on 'localhost:49270' 15:40:22 INFO - SUITE-START | Running 2 tests 15:40:22 INFO - TEST-START | dromaeo_css 15:40:22 INFO - operating with platform_type : mac_ 15:40:22 INFO - Initialising browser for dromaeo_css test... 15:40:22 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpLk41vc/profile http://localhost:49270/getInfo.html) 15:40:25 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 15:40:25 INFO - PROCESS | 1661 | colorDepth:24 15:40:25 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 15:40:25 INFO - PROCESS | 1661 | __metrics 15:40:25 ERROR - PROCESS | 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:40:26 INFO - TEST-INFO | 1661: exit 0 15:40:26 INFO - Browser initialized. 15:40:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:40:26 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmpLk41vc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:38 INFO - PROCESS | 1666 | RSS: Main: 170881024 15:40:38 INFO - PROCESS | 1666 | 15:41:28 INFO - PROCESS | 1666 | 1467931288034 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:43:38 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 15:43:39 INFO - PROCESS | 1666 | RSS: Main: 182071296 15:43:39 INFO - PROCESS | 1666 | 15:46:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 15:46:41 INFO - PROCESS | 1666 | RSS: Main: 192724992 15:46:41 INFO - PROCESS | 1666 | 15:49:43 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 15:49:44 INFO - PROCESS | 1666 | RSS: Main: 194732032 15:49:44 INFO - PROCESS | 1666 | 15:52:45 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 15:52:46 INFO - PROCESS | 1666 | RSS: Main: 198549504 15:52:46 INFO - PROCESS | 1666 | 15:55:49 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 15:55:49 INFO - PROCESS | 1666 | RSS: Main: 197492736 15:55:49 INFO - PROCESS | 1666 | 15:58:51 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 15:58:52 INFO - PROCESS | 1666 | RSS: Main: 202498048 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | __start_tp_report 15:58:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 15:58:52 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 15:58:52 INFO - PROCESS | 1666 | |i|pagename|runs| 15:58:52 INFO - PROCESS | 1666 | |0;dojo.html;3609.1518493154113;3661.8901432957014;3689.409694448889;3697.963020369797;3723.1809002019563;5861.443162899518;5876.030454974929;5876.941230587688;5880.7059647017695;5931.85170370741;5908.88182236355;5911.704414779266;5928.6739229342365;5949.553783466246;5961.433663801943;5334.226537152111;5344.973275133619;5346.973265133669;5396.568274538027;5530.281063461744;5304.416514183436;5386.757595908193;5419.566434685235;5423.83728488144;5465.480779325978;5386.973065134669;5401.756920938547;5403.648762830403;5415.972920135414;5428;4186.958130418688;5407.783688652469;5428.75570599324;5451.127819548893;5493.395726470085;5283.788648454057;5363.946360536423;5365.275687782138;5405.432429594875;5405.945940540583;5823.970880145572;5825.533957283407;5855.795047173371;5860.472557469848;5872.794452194153;6178.907316390258;6246.843828904268;6256.405641464054;6257.061440783873;6294.653794041325;5218.530332270114;6219.689015549205;6231.532635052344;6242.781502647385;6256.718447669866;5862.794802181903;5871.5596330274975;5921.437463441052;5930.495907847881;5931.377205393414;6237.064440333987;6256.5307601930035;6317.210348706411;6349.555531112777;6380.425761681471;6224.9417599008275;6238.220222472191;6240.251169859646;6241.313455519889;6258.968705156445;6233.065040244;6294.874102517924;6299.874002519924;6304.05439184126;6313.43179113882;6168.753249870045;6214.192155019909;6240.812775616739;6249.281332646713;6267.1539342189135;6203.286622038523;6211.844703882349;6235.96882015587;6236.501079913596;6250.3749625037135;4938.185199442052;4995.9500404996215;5090.592752579785;5101.132807422747;5109.284700141983;3865.7100717446306;4551.977240113778;4587.655925805511;4638.095571363552;4646.628269738413;5057.671251368649;6118.510519158456;6123.112148738497;6161.599496032743;6166;6229.470495007975;6243.094751261133;6251.781187658501;6279.874402511924;6302.243730752339;6016.097585362143;6111.591738512148;6171.506279497629;6181;6197.4732147767045;4865.854024379274;5000.249962505581;5287.995280896617;5587.245721827582;5617.129344951539;6484.124643173205;6598.406143447209;6737.562058466184;6744.865102697919;6748.662566871637;6261.718222680081;6283.7800676976085;6286.18279623646;6299.779507717208;6315.021171718391;6738.056672065817;6760.830979225362;6761.898571521333;6762.661866906733;6767;6203.503719702323;6229.127922091002;6246.6876656167915;6247.312795592572;6261.8747625046335;6278.591891527036;6283.5601507895835;6288.811335659938;6294.748210071729;6295.842603934938;6249.218847644044;6252.343503932204;6267.905981410191;6268.404501572343;6268.655223962726;6045.365236650265;6138.9095594588325;6211.751529938932;6251.937480625317;6283.277423096402;6099.817005489843;6107.144999700135;6114.052321890114;6117.327094019565;6168.629882207082;6140.048292514667;6189.721462534107;6265.185525881606;6280.937190628035;6295.244570651551;6024.126501657148;6135.84660383494;6186.19579454668;6205;6214.72033758491 15:58:52 INFO - PROCESS | 1666 | |1;ext.html;559.1277606933182;561.3151954615367;562.7130163616556;579.2585490572068;603.9280277507423;38651;39530.80234598827;39649.40525892107;39668.20663586734;39763.40354894671;41193;41722.37416438756;41761;41824.37263441051;41907.790461047654;8871.600777964975;9419.246460283195;9668.178204852578;9898.90101098987;9909.207263418944;9544.47505387207;9611.183049440771;9753;9773.462459564722;9792.21662267017;9738.415695058318;9760.121589056984;9791.265655075862;9793.755156121082;9825.754356141082;9750.219982401391;9756.414615123116;9790.804183916352;9794.412335259907;9825;9757.90242097577;9802.901970980342;9881.456519891402;9907.900920990769;9912.355696879751;39941.60058399437;39977.80011099955;40229;40276;40393.99015024619;3329.6004479462376;3354.194993201638;3449.292894956528;3465.705415039725;3495.702865256431;28390.148295551167;29518.55722164169;29580.260493487618;29935;30124.397512049636;2401.903923843044;2537.796976241896;2841.7442430181177;2880.985595072032;2913.67949525552;420905.79094208975;445094;473383;478445;481338;37324.81337593349;55215.72392138014;61613;61706.69146654238;61746.765064698455;30795.69204307928;36255.093622659646;36649.267014660094;36713.81643091821;36865.44701829475;16414.015159090493;16488.422905198262;16655.41706040283;16657.91671041637;16700.58248543796;13947.302634868216;14150.646233844236;14151.504697335544;14168.645783855485;14193.290335483185;8106.675732970733;8169.550674712829;8339.332853371716;8492.320614350838;8508.65965361391;3583.5699716033723;3590.2101537661674;3618.2401695643684;3620.094976255936;3636.1818590816856;1055.7624534479835;1081.1837063017372;1081.3403823667556;1085.8273065089843;1087.211771465681;31898.84050579732;31974.360512789615;32000.839995799874;32215.194620134684;32657.69369225252;1189.2032338333338;1191.576990168495;1221.0841868598552;1274.2354587247762;1356.1930651262483;15873.761893571605;16095.678086438205;16215;16244.269007894673;16515.421960231575;661011;670261;739873;755669;755849;63634.68182659057;63947.36052639414;64611.353886461475;64690;64888.675556621914;1567.5924259692333;1576.7398379267522;1578.6921550297582;1583.0580804421352;1586.1197035645328;24152.134427759003;30553;30635.08094757161;30956;31123.84438077795;56065.719671401384;56319;56595.71702141463;56693.43306566882;56875.14687279611;585743;587944;592951;603456;605313;27869.860650696617;28077.859610701817;28570.42859142764;28675.13974580766;28987.5651865218;37767.81116094402;47305.29042064441;47592.52407475881;47945.76027119842;48802;37110.886673399844;37683.223843131396;37841.81079094587;37901.620983789806;38067.04832379213;37613.87158385253;37642;37692;37800.62199377971;38095.42856857094;32802.19587922592;38014.80992595019;39032;39805.80097099496;39893.80318590447;31249.531257031616;32694.509582355808;33033.50449743304;33037.66962330442;33085.66914330826;25068.24795256145;25275.49449011046;25441.236762897144;25670.358241043377;25679 15:58:52 INFO - PROCESS | 1666 | |2;jquery.html;371.5931055494234;415.96464300534456;417.0408061458645;423.2550710749081;426.1285670803207;20351;20952.580948381023;21100.472488187803;21126.943652817376;22044.448888777788;21725.782742172574;21907.561848763016;22247.44381390462;22455.775442245573;22803.77196228037;5542.946840100378;6194.411530904579;6249.218847644044;6274.1529893464485;6279.560430769848;6019;6176.567640265183;6189.978653522164;6193.380661933793;6216.751329946796;5169.974150129244;5859.970700146493;6034.4568988791;6140.201773769404;6169.383061693818;5431.538319242869;5862.208601838761;5932.406519654849;5975.581709280352;6000.189974353472;5238.816641417532;5372.7045012524295;5383.838484845422;5398.055340315429;5413.891722165574;22185.11259549616;27105.322366940985;27379;27396.45207095847;27602.723972760217;2302.7697230277004;2350.612148995414;2397.280815755284;2466.025919761702;2737.2609395463114;15369.154696491689;15794.763078553831;15978.840211597852;16026.118563479004;16389.426370077108;1778.1820362633205;1837.5130590393555;1864.2449807827852;1897.155765684271;1926.8747531410413;103669;113141.43429282884;113461;115704;117445.41277293558;12049.939750301193;12208.877911220952;12232.204906681216;12270.079744019235;12315.99999999982;15041.849581504264;15050.473233436776;15107.244637768068;15477;15490.612734681497;7978.5611791350875;8421.073681894986;9271.258299336172;9349.90650093504;9442.055794420641;9272.907270927339;9293.907060929305;9358.315503209487;9363.297752668577;9421.010793866682;4242;4782.067496838084;4839.564439200489;4864.610831133501;4887.462379138292;1771.8305918093997;2014.6831144184305;2125.234915430444;2146.828253739697;2150.720406347165;932.8181004704153;1023.513830930317;1024.8718910136083;1080.7514271717391;1094.9726256843483;20329.695054574193;20837.270695525585;20899.47751306199;20907.790922090586;21211.575768484545;948.2508818033814;957.7740492170034;1057.619257067455;1067.4609322292192;1098.8296813993843;8747.956260218658;9206.26349892007;10668.786624267626;10786.46067696612;10856.511456984455;641917;659274;659398;682042;691512.5424372846;72127;112954;113602;115332;129391.35304323418;1052.4737631184407;1082.3181395720803;1088.8257878739523;1089.84742136101;1092.6503518874042;15084.547463576111;16481.505554833373;18983.810161898204;19469.51326216856;19476;54150.916981660936;55747.60630984258;55874.44125558692;56369.43630563642;57272.140917887096;79322.2067779338;82376;82843;82923.58538207512;84770;8042.9597852010365;8325;8498.830023399374;8506.234438900528;8517.616707248064;11196.832047519456;12382.504699811907;12524.060695447695;12648.620541383772;12988.895943844502;10744;11140.498677559368;11155.27490713101;11199.377257938755;11208.439578021229;8849.557522123996;9191.908080919105;9261.768455788659;11029.779404412027;11341.149413794163;11196.776064478501;11678.70803229926;11784.58753943608;11810.40947952616;11923.0461563073;8097.919020809953;8234.958825206075;8425.115362887054;8585.055643879043;8636;8435.072142064246;9960.850587241343;10721.445390418501;10972;11938.164328496921 15:58:52 INFO - PROCESS | 1666 | |3;mootools.html;1656.8591669708073;1683.6969345517805;1989.6020795840827;2029.2086086426286;2131.872087674739;8210.958945205266;8882.978457477391;8969.686060987866;9120.8631870522;9160.404573702714;8942.19520243178;8983.685571005017;9001.054889236633;9094.45433274004;9115.908840911588;2531.2785856030987;2544.37662772621;2564.24354815329;2567.319660290025;2573.369524466508;2489.7012358516913;2490.3151633300895;2493.1024831060804;2498.6252062190633;2503.7871780898645;2114.260008996854;2428.720697119836;2540.593505039194;2570.8714564271804;2573.4338445541953;2534.9239522814346;2541.8983240670445;2566.8973241070335;2574.9485010299877;2582.5738753105716;2108.68369744538;2530.683664541932;2559.5264875998;2572.421205228827;2574.4979728952862;8960.731178064669;9163.541822908828;9205.723828285161;9220.44677319363;9225.723228303095;5523.8066667666435;5677.801276955287;5680.4319568043275;5719.857003574903;5720.771169153229;3126.5310203469435;3625.1118475973553;3699.667029967316;3754.6295602105306;3760.304343696425;1064.5741703318656;1070.82866741321;1071.9678409647722;1072.447689439939;1072.8176210044232;12020.338881361522;12242.938785306016;12295.631131066082;12303.630891073282;12324;4040.373742069984;4955.950440495549;4961.925571116436;5038.420581633086;5076.0863044652315;10383.688489345332;10389.324693894872;10406;10439.425831579185;10487.951204879451;4660.440747110369;5620.297462817148;5642.943570564242;5679.176519404746;5735.942640573624;4641.419822522184;5045.5459008689395;5122.154844450624;5156.329677142023;5228.581713462914;4230.386593943861;4271.508776490681;4290.570942905747;4365.410669559632;4419.690621656453;1190.9464074116513;1420.5170242117729;1439.5105664074265;1449.311577000916;1449.6955639315652;884.4162852517436;944.6363150187227;973.4791886340773;1007.9647212347533;1018.032868774667;5236.6857988520815;6028.216331876828;6036.909446358308;6066.787662431793;6267.592606480564;978.3005151316701;978.4178413843752;1042.6142327338932;1059.7668512927144;1074.9193810464246;3998.1608460108678;4161.667066634662;4188.706790524634;4189.036521600049;4259.467566554181;10784.784304314027;11039.558417663364;11068.00387965087;11235.94382028101;11318.547258109584;9395;10976.341419514854;11016.394098324668;11051.336919784839;11102.44487775608;8185.836283274421;8566.3146948244;8652;8716.346274029347;8790.516521591246;6134.754609815557;6201.550387596827;6258.749650014131;6262.843428914313;6269.3417191196095;9938.204943604638;10030.448325342177;10047.497625118862;10068.194544436574;10134.543945522322;9866.851997219905;10200.0819926207;10229.130523905551;10360.119389851947;10380.377177369382;7127.893081603676;7504.137024242282;7722.420818438527;7800.907872897912;7914.525128492309;8334.416590838584;8514;8556.18716221958;8581.485110893367;8604.78488037804;7548.811279718051;7640.465167438226;7685.961570192113;7711.190325016017;7822.335101516207;7462.888056679046;7494.325510703845;7509;7510.211427800003;7644.044494438195;7174.246704096204;7196.856062878608;7201.459890508128;7230.710771569078;7235.2764723529335;4966.130927087817;4979.800807967786;5077.289179514944;5131.56381707559;5191.299174611379;5123.436421993503;5133.4096578893905;5174.6119041071315;5204.297419848272;5260.526552610283 15:58:52 INFO - PROCESS | 1666 | |4;prototype.html;336.1795875335061;341.1233130853706;341.7795521888382;346.57544507977724;349.07321062578865;6699.899501507482;6749.49378796591;6760.628165450905;6821.420179284761;6847.246802851689;5454.61817672763;6876.518643694943;6894.034835123087;6904;6905.413039891602;5105.3873535175835;5115.181570948649;5119.897602047957;5121.385433747955;5135.922961155586;4402.691811573175;4863.708177509343;5119.56483698886;5149.665271757323;5150.098732721777;5081.46644602317;5099.71951542665;5101.642884998052;5101.872453188663;5123.820666276681;4756.548127927841;4914.16459201933;5093.2105523643895;5094.7197904115255;5097.541221290083;4152.875413737563;4171.666266698657;4176.665866730655;4193.35003074524;4209.957900420987;6353.110564520971;6424.421802037792;6451.322611125811;6462.709178086998;6492.513061520405;5816.272965879265;5879.412058794129;5885.352611212763;5891.823245302648;5916.3787802281;6393.7762178324;6822.5565338253355;7264.600446975467;7276.599787011713;7277.963610181915;4546.636269098497;4701.059788042405;4716.6698331116495;4735.905281894343;4740.360051393052;7616;7651.5409075455655;7683.538987660702;7726.34326082278;7729.690812367555;4797.496262892346;4801.18379875422;4814.325994360793;4815.398075240595;4821.325014497973;4888.169011268093;4890.437599676083;4893.828715994923;4896.069746748107;4900.848300649344;4832.323474713543;5062.291279220912;5618.887622247532;5762.049261871828;5856.707164641751;7090.4327653788605;7340.779776606711;7346.853062938818;7357.682330066012;7399.334059934632;1671.3648813450811;1676.6814305281957;1691.6532110917233;1692.3991982846157;1693.889897156681;848.5587494502824;1060.7242117049468;1063.5320458998017;1080.2492267873909;1081.0918828184363;6940.7917762467205;6952.636103724758;7018.824529386806;7032.6132062736015;7033.542819716702;7216.386607138347;7509.249075092556;7593.088829340514;7613.352865006536;7639.69441222356;7109.786706398816;7122.5726456412785;7137.394086330534;7140.464465165133;7144.142702875688;3917.193868314574;3960.148568057881;3981.6814654827544;4042.6765858731233;4056.3104272273786;8200.5489698066;8250.257476827115;8259.297959673375;8269;8276.50340979531;6468.870622587522;7755.991721076224;7898;7917.535255977663;7919.366450683931;8145.429819912668;8197.46716463428;8202;8205.917940820635;8227.629756660965;7392.221353667249;7485.70057197706;7599.88600171009;7602.353799927068;7642.541447513167;7424.96287518559;7439.962800185965;7449.888251676338;7455.6644950978425;7473.88789168152;8161.387895907949;8204;8211.671533138608;8244.587770611326;8247.422680412314;4802.159622066194;4816.8554943351755;4818.903621927471;4829.830955916526;4832.106060378841;6550.213974323112;7125.966734823318;7330.633468326669;7590.506617069873;7606.847863042819;6326.766280575428;6945.583265004116;7365.631718413951;7382.704691812482;7385.29839665231;7284.781456556312;7315.195328513752;7326.743563975236;7348.1182258129365;7350.338469537767;6264.404881536247;7159.926011098377;7164.355208031302;7177.641117944187;7184.568925864465;6994.720211191496;7092.858142837011;7325.890111648223;7338.046054012944;7432.145303290191;6418;6580.144581204604;6885.552439091443;7017.508774385744;7132.322429369202 15:58:52 INFO - PROCESS | 1666 | |5;yui.html;725.6190499987506;773.7021246819976;785.0971382909656;798.7204478432548;823.3536673711138;14694.55916322512;14803.555893323191;15064.171470569128;15072.698546029073;15097.924510377446;14270.785938210935;14322;14350.138991660482;14365.209913454755;14380.856191438083;773.0993392697501;890.8084761776216;954.308126608207;954.5609019850876;974.3325821812045;901.8737376767258;902.8600566912139;939.1078475448318;944.3342443577261;974.9908844346103;974.3958745577752;974.6880998080617;1001.644416232238;1012.9566546457124;1048.6591857646258;969.2246203037541;994.6419289055934;1021.4433133941945;1026.9589216431334;1042.2547878267037;750.7747675697269;783.6042798386778;785.7603430953557;786.2255678157011;788.4283894176733;15313.540593782205;15317.234138293152;15347.693046139015;15362;15464;13123.934380328037;13250.801237981437;13302.600921972356;13310.800337994939;13460.932695336558;10365.37807731531;10392.948035259851;10413.427261500614;10427.113695335906;10558.366498010144;3141.2932090279505;3619.059044648384;3636.127329440915;3686.4838922550866;3847.9807600961817;81741.59129204375;82911.585442073;84195.57902210511;85109.87225319355;85448.14551854464;9712.75718107053;9805.80388392228;9913.950430247802;9931.453770042717;10155.441450720133;22670;22842.885785570965;22844.885775571016;22875.656865147037;22880.855957202406;7572.015637967139;7633.923660763432;7641.121271053788;7677;7720.806979825549;4134.441850350225;4181.121964387452;4193.182329445729;4195.202911446815;4210.45264115663;3710.8144592770254;3714.814259287025;3760.8683696070507;3760.8683696070507;3781.357169281229;562.4488001758218;664.0703015777854;665.1452883045264;680.8468094678757;682.2836022176695;570.1476292942078;583.096200888621;600.177756473634;627.7740013595102;633.2021652717517;8286.751397458085;8292.709755158541;8382.119877412784;8415.579221039046;8608.42713417676;510.2703134517601;577.6534079552235;627.6987046217749;634.6319134901746;640.9327020662856;3386.4243078676686;3536.9565978036026;3744.5506539215467;3933.3316724382544;4007.1785284016705;93364;95219;95993.04006959981;96433.0356696424;97181;57537.712311438176;75610;76623.23376766162;77869.22130778733;78563.60718196486;68787;70728;71111.64444177746;72620;72800.63599682074;6774.491913106438;7697.961510192637;7954.862912559374;8039.1156972734125;8041.67833286662;45875.311870321304;46117.76941115273;47240.763796182175;47256.81857953441;47954.28068578905;59761.40238597558;61061.77876442357;61966.380336197864;62647.6867615659;62992.055119172335;9134.177923986874;10238.078572928473;10423.843642345219;10620.09729173029;10698.06643529995;10995.285306455055;11075.833862491907;11153.219274650697;11297.378644174649;11608.361540115375;10497.895021049691;10701.678949631523;10953.780924381308;10962.177836662122;11101.389423581457;10340;10606.098481629147;10615.681529554126;10651.30766500175;10911.018008379284;10319.019693129141;10322.071013608811;10571.62999295021;10605.204609654462;11043.337399756041;8968.327375446737;9204.677836275698;9231.35380523357;9370.10983956523;9703.708888733348;9781.070798274153;9861.506924653595;9931.702048938543;10035.34770239932;10113.64602238918 15:58:52 INFO - PROCESS | 1666 | __end_tp_report 15:58:52 INFO - PROCESS | 1666 | __start_cc_report 15:58:52 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,390 15:58:52 INFO - PROCESS | 1666 | __end_cc_report 15:58:52 INFO - PROCESS | 1666 | __startTimestamp1467932332027__endTimestamp 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | ------- Summary: start ------- 15:58:52 INFO - PROCESS | 1666 | Number of tests: 6 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5874.76 Median:6168.63 stddev:645.37 (10.5%) stddev-sans-first:622.39 15:58:52 INFO - PROCESS | 1666 | Values: 3609.2 3661.9 3689.4 3698.0 3723.2 5861.4 5876.0 5876.9 5880.7 5931.9 5908.9 5911.7 5928.7 5949.6 5961.4 5334.2 5345.0 5347.0 5396.6 5530.3 5304.4 5386.8 5419.6 5423.8 5465.5 5387.0 5401.8 5403.6 5416.0 5428.0 4187.0 5407.8 5428.8 5451.1 5493.4 5283.8 5363.9 5365.3 5405.4 5405.9 5824.0 5825.5 5855.8 5860.5 5872.8 6178.9 6246.8 6256.4 6257.1 6294.7 5218.5 6219.7 6231.5 6242.8 6256.7 5862.8 5871.6 5921.4 5930.5 5931.4 6237.1 6256.5 6317.2 6349.6 6380.4 6224.9 6238.2 6240.3 6241.3 6259.0 6233.1 6294.9 6299.9 6304.1 6313.4 6168.8 6214.2 6240.8 6249.3 6267.2 6203.3 6211.8 6236.0 6236.5 6250.4 4938.2 4996.0 5090.6 5101.1 5109.3 3865.7 4552.0 4587.7 4638.1 4646.6 5057.7 6118.5 6123.1 6161.6 6166.0 6229.5 6243.1 6251.8 6279.9 6302.2 6016.1 6111.6 6171.5 6181.0 6197.5 4865.9 5000.2 5288.0 5587.2 5617.1 6484.1 6598.4 6737.6 6744.9 6748.7 6261.7 6283.8 6286.2 6299.8 6315.0 6738.1 6760.8 6761.9 6762.7 6767.0 6203.5 6229.1 6246.7 6247.3 6261.9 6278.6 6283.6 6288.8 6294.7 6295.8 6249.2 6252.3 6267.9 6268.4 6268.7 6045.4 6138.9 6211.8 6251.9 6283.3 6099.8 6107.1 6114.1 6117.3 6168.6 6140.0 6189.7 6265.2 6280.9 6295.2 6024.1 6135.8 6186.2 6205.0 6214.7 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:71099.97 Median:37958.22 stddev:161096.85 (424.4%) stddev-sans-first:161461.71 15:58:52 INFO - PROCESS | 1666 | Values: 559.1 561.3 562.7 579.3 603.9 38651.0 39530.8 39649.4 39668.2 39763.4 41193.0 41722.4 41761.0 41824.4 41907.8 8871.6 9419.2 9668.2 9898.9 9909.2 9544.5 9611.2 9753.0 9773.5 9792.2 9738.4 9760.1 9791.3 9793.8 9825.8 9750.2 9756.4 9790.8 9794.4 9825.0 9757.9 9802.9 9881.5 9907.9 9912.4 39941.6 39977.8 40229.0 40276.0 40394.0 3329.6 3354.2 3449.3 3465.7 3495.7 28390.1 29518.6 29580.3 29935.0 30124.4 2401.9 2537.8 2841.7 2881.0 2913.7 420905.8 445094.0 473383.0 478445.0 481338.0 37324.8 55215.7 61613.0 61706.7 61746.8 30795.7 36255.1 36649.3 36713.8 36865.4 16414.0 16488.4 16655.4 16657.9 16700.6 13947.3 14150.6 14151.5 14168.6 14193.3 8106.7 8169.6 8339.3 8492.3 8508.7 3583.6 3590.2 3618.2 3620.1 3636.2 1055.8 1081.2 1081.3 1085.8 1087.2 31898.8 31974.4 32000.8 32215.2 32657.7 1189.2 1191.6 1221.1 1274.2 1356.2 15873.8 16095.7 16215.0 16244.3 16515.4 661011.0 670261.0 739873.0 755669.0 755849.0 63634.7 63947.4 64611.4 64690.0 64888.7 1567.6 1576.7 1578.7 1583.1 1586.1 24152.1 30553.0 30635.1 30956.0 31123.8 56065.7 56319.0 56595.7 56693.4 56875.1 585743.0 587944.0 592951.0 603456.0 605313.0 27869.9 28077.9 28570.4 28675.1 28987.6 37767.8 47305.3 47592.5 47945.8 48802.0 37110.9 37683.2 37841.8 37901.6 38067.0 37613.9 37642.0 37692.0 37800.6 38095.4 32802.2 38014.8 39032.0 39805.8 39893.8 31249.5 32694.5 33033.5 33037.7 33085.7 25068.2 25275.5 25441.2 25670.4 25679.0 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36744.05 Median:2326.69 stddev:110290.61 (4740.2%) stddev-sans-first:110566.19 15:58:52 INFO - PROCESS | 1666 | Values: 371.6 416.0 417.0 423.3 426.1 20351.0 20952.6 21100.5 21126.9 22044.4 21725.8 21907.6 22247.4 22455.8 22803.8 5542.9 6194.4 6249.2 6274.2 6279.6 6019.0 6176.6 6190.0 6193.4 6216.8 5170.0 5860.0 6034.5 6140.2 6169.4 5431.5 5862.2 5932.4 5975.6 6000.2 5238.8 5372.7 5383.8 5398.1 5413.9 22185.1 27105.3 27379.0 27396.5 27602.7 2302.8 2350.6 2397.3 2466.0 2737.3 15369.2 15794.8 15978.8 16026.1 16389.4 1778.2 1837.5 1864.2 1897.2 1926.9 103669.0 113141.4 113461.0 115704.0 117445.4 12049.9 12208.9 12232.2 12270.1 12316.0 15041.8 15050.5 15107.2 15477.0 15490.6 7978.6 8421.1 9271.3 9349.9 9442.1 9272.9 9293.9 9358.3 9363.3 9421.0 4242.0 4782.1 4839.6 4864.6 4887.5 1771.8 2014.7 2125.2 2146.8 2150.7 932.8 1023.5 1024.9 1080.8 1095.0 20329.7 20837.3 20899.5 20907.8 21211.6 948.3 957.8 1057.6 1067.5 1098.8 8748.0 9206.3 10668.8 10786.5 10856.5 641917.0 659274.0 659398.0 682042.0 691512.5 72127.0 112954.0 113602.0 115332.0 129391.4 1052.5 1082.3 1088.8 1089.8 1092.7 15084.5 16481.5 18983.8 19469.5 19476.0 54150.9 55747.6 55874.4 56369.4 57272.1 79322.2 82376.0 82843.0 82923.6 84770.0 8043.0 8325.0 8498.8 8506.2 8517.6 11196.8 12382.5 12524.1 12648.6 12988.9 10744.0 11140.5 11155.3 11199.4 11208.4 8849.6 9191.9 9261.8 11029.8 11341.1 11196.8 11678.7 11784.6 11810.4 11923.0 8097.9 8235.0 8425.1 8585.1 8636.0 8435.1 9960.9 10721.4 10972.0 11938.2 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5922.76 Median:4958.94 stddev:3263.51 (65.8%) stddev-sans-first:3256.92 15:58:52 INFO - PROCESS | 1666 | Values: 1656.9 1683.7 1989.6 2029.2 2131.9 8211.0 8883.0 8969.7 9120.9 9160.4 8942.2 8983.7 9001.1 9094.5 9115.9 2531.3 2544.4 2564.2 2567.3 2573.4 2489.7 2490.3 2493.1 2498.6 2503.8 2114.3 2428.7 2540.6 2570.9 2573.4 2534.9 2541.9 2566.9 2574.9 2582.6 2108.7 2530.7 2559.5 2572.4 2574.5 8960.7 9163.5 9205.7 9220.4 9225.7 5523.8 5677.8 5680.4 5719.9 5720.8 3126.5 3625.1 3699.7 3754.6 3760.3 1064.6 1070.8 1072.0 1072.4 1072.8 12020.3 12242.9 12295.6 12303.6 12324.0 4040.4 4956.0 4961.9 5038.4 5076.1 10383.7 10389.3 10406.0 10439.4 10488.0 4660.4 5620.3 5642.9 5679.2 5735.9 4641.4 5045.5 5122.2 5156.3 5228.6 4230.4 4271.5 4290.6 4365.4 4419.7 1190.9 1420.5 1439.5 1449.3 1449.7 884.4 944.6 973.5 1008.0 1018.0 5236.7 6028.2 6036.9 6066.8 6267.6 978.3 978.4 1042.6 1059.8 1074.9 3998.2 4161.7 4188.7 4189.0 4259.5 10784.8 11039.6 11068.0 11235.9 11318.5 9395.0 10976.3 11016.4 11051.3 11102.4 8185.8 8566.3 8652.0 8716.3 8790.5 6134.8 6201.6 6258.7 6262.8 6269.3 9938.2 10030.4 10047.5 10068.2 10134.5 9866.9 10200.1 10229.1 10360.1 10380.4 7127.9 7504.1 7722.4 7800.9 7914.5 8334.4 8514.0 8556.2 8581.5 8604.8 7548.8 7640.5 7686.0 7711.2 7822.3 7462.9 7494.3 7509.0 7510.2 7644.0 7174.2 7196.9 7201.5 7230.7 7235.3 4966.1 4979.8 5077.3 5131.6 5191.3 5123.4 5133.4 5174.6 5204.3 5260.5 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5979.89 Median:6821.99 stddev:1941.05 (28.5%) stddev-sans-first:1899.71 15:58:52 INFO - PROCESS | 1666 | Values: 336.2 341.1 341.8 346.6 349.1 6699.9 6749.5 6760.6 6821.4 6847.2 5454.6 6876.5 6894.0 6904.0 6905.4 5105.4 5115.2 5119.9 5121.4 5135.9 4402.7 4863.7 5119.6 5149.7 5150.1 5081.5 5099.7 5101.6 5101.9 5123.8 4756.5 4914.2 5093.2 5094.7 5097.5 4152.9 4171.7 4176.7 4193.4 4210.0 6353.1 6424.4 6451.3 6462.7 6492.5 5816.3 5879.4 5885.4 5891.8 5916.4 6393.8 6822.6 7264.6 7276.6 7278.0 4546.6 4701.1 4716.7 4735.9 4740.4 7616.0 7651.5 7683.5 7726.3 7729.7 4797.5 4801.2 4814.3 4815.4 4821.3 4888.2 4890.4 4893.8 4896.1 4900.8 4832.3 5062.3 5618.9 5762.0 5856.7 7090.4 7340.8 7346.9 7357.7 7399.3 1671.4 1676.7 1691.7 1692.4 1693.9 848.6 1060.7 1063.5 1080.2 1081.1 6940.8 6952.6 7018.8 7032.6 7033.5 7216.4 7509.2 7593.1 7613.4 7639.7 7109.8 7122.6 7137.4 7140.5 7144.1 3917.2 3960.1 3981.7 4042.7 4056.3 8200.5 8250.3 8259.3 8269.0 8276.5 6468.9 7756.0 7898.0 7917.5 7919.4 8145.4 8197.5 8202.0 8205.9 8227.6 7392.2 7485.7 7599.9 7602.4 7642.5 7425.0 7440.0 7449.9 7455.7 7473.9 8161.4 8204.0 8211.7 8244.6 8247.4 4802.2 4816.9 4818.9 4829.8 4832.1 6550.2 7126.0 7330.6 7590.5 7606.8 6326.8 6945.6 7365.6 7382.7 7385.3 7284.8 7315.2 7326.7 7348.1 7350.3 6264.4 7159.9 7164.4 7177.6 7184.6 6994.7 7092.9 7325.9 7338.0 7432.1 6418.0 6580.1 6885.6 7017.5 7132.3 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18128.31 Median:29053.93 stddev:25589.16 (88.1%) stddev-sans-first:25627.58 15:58:52 INFO - PROCESS | 1666 | Values: 725.6 773.7 785.1 798.7 823.4 14694.6 14803.6 15064.2 15072.7 15097.9 14270.8 14322.0 14350.1 14365.2 14380.9 773.1 890.8 954.3 954.6 974.3 901.9 902.9 939.1 944.3 975.0 974.4 974.7 1001.6 1013.0 1048.7 969.2 994.6 1021.4 1027.0 1042.3 750.8 783.6 785.8 786.2 788.4 15313.5 15317.2 15347.7 15362.0 15464.0 13123.9 13250.8 13302.6 13310.8 13460.9 10365.4 10392.9 10413.4 10427.1 10558.4 3141.3 3619.1 3636.1 3686.5 3848.0 81741.6 82911.6 84195.6 85109.9 85448.1 9712.8 9805.8 9914.0 9931.5 10155.4 22670.0 22842.9 22844.9 22875.7 22880.9 7572.0 7633.9 7641.1 7677.0 7720.8 4134.4 4181.1 4193.2 4195.2 4210.5 3710.8 3714.8 3760.9 3760.9 3781.4 562.4 664.1 665.1 680.8 682.3 570.1 583.1 600.2 627.8 633.2 8286.8 8292.7 8382.1 8415.6 8608.4 510.3 577.7 627.7 634.6 640.9 3386.4 3537.0 3744.6 3933.3 4007.2 93364.0 95219.0 95993.0 96433.0 97181.0 57537.7 75610.0 76623.2 77869.2 78563.6 68787.0 70728.0 71111.6 72620.0 72800.6 6774.5 7698.0 7954.9 8039.1 8041.7 45875.3 46117.8 47240.8 47256.8 47954.3 59761.4 61061.8 61966.4 62647.7 62992.1 9134.2 10238.1 10423.8 10620.1 10698.1 10995.3 11075.8 11153.2 11297.4 11608.4 10497.9 10701.7 10953.8 10962.2 11101.4 10340.0 10606.1 10615.7 10651.3 10911.0 10319.0 10322.1 10571.6 10605.2 11043.3 8968.3 9204.7 9231.4 9370.1 9703.7 9781.1 9861.5 9931.7 10035.3 10113.6 15:58:52 INFO - PROCESS | 1666 | -------- Summary: end -------- 15:58:52 INFO - PROCESS | 1666 | 15:58:52 INFO - TEST-INFO | 1666: exit 0 15:58:52 INFO - TEST-OK | dromaeo_css | took 1109734ms 15:58:52 INFO - TEST-START | kraken 15:58:52 INFO - operating with platform_type : mac_ 15:58:52 INFO - Initialising browser for kraken test... 15:58:52 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmp2yu3F3/profile http://localhost:49270/getInfo.html) 15:58:55 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 15:58:55 INFO - PROCESS | 1674 | colorDepth:24 15:58:55 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 15:58:55 INFO - PROCESS | 1674 | __metrics 15:58:55 ERROR - PROCESS | 1674 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 15:58:55 INFO - TEST-INFO | 1674: exit 0 15:58:55 INFO - Browser initialized. 15:58:55 INFO - Running cycle 1/1 for kraken test... 15:58:55 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/T/tmp2yu3F3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:59:07 INFO - PROCESS | 1678 | RSS: Main: 170782720 15:59:07 INFO - PROCESS | 1678 | 15:59:10 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 15:59:11 INFO - PROCESS | 1678 | RSS: Main: 183717888 15:59:11 INFO - PROCESS | 1678 | 15:59:14 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 15:59:14 INFO - PROCESS | 1678 | RSS: Main: 192339968 15:59:14 INFO - PROCESS | 1678 | 15:59:17 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 15:59:18 INFO - PROCESS | 1678 | RSS: Main: 195936256 15:59:18 INFO - PROCESS | 1678 | 15:59:20 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 15:59:21 INFO - PROCESS | 1678 | RSS: Main: 196091904 15:59:21 INFO - PROCESS | 1678 | 15:59:23 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:59:24 INFO - PROCESS | 1678 | RSS: Main: 197816320 15:59:24 INFO - PROCESS | 1678 | 15:59:26 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 15:59:27 INFO - PROCESS | 1678 | RSS: Main: 198139904 15:59:27 INFO - PROCESS | 1678 | 15:59:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 15:59:31 INFO - PROCESS | 1678 | RSS: Main: 198336512 15:59:31 INFO - PROCESS | 1678 | 15:59:34 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 15:59:34 INFO - PROCESS | 1678 | RSS: Main: 198414336 15:59:34 INFO - PROCESS | 1678 | 15:59:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:59:37 INFO - PROCESS | 1678 | RSS: Main: 197849088 15:59:37 INFO - PROCESS | 1678 | 15:59:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:59:39 INFO - PROCESS | 1678 | RSS: Main: 197885952 15:59:39 INFO - PROCESS | 1678 | 15:59:41 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:59:42 INFO - PROCESS | 1678 | RSS: Main: 197865472 15:59:42 INFO - PROCESS | 1678 | 15:59:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:59:46 INFO - PROCESS | 1678 | RSS: Main: 198045696 15:59:46 INFO - PROCESS | 1678 | 15:59:48 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:59:49 INFO - PROCESS | 1678 | RSS: Main: 197931008 15:59:49 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 15:59:51 INFO - PROCESS | 1678 | RSS: Main: 199811072 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | __start_tp_report 15:59:51 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 15:59:51 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 15:59:51 INFO - PROCESS | 1678 | |i|pagename|runs| 15:59:51 INFO - PROCESS | 1678 | |0;ai-astar;115;114;116;117;117;131;115;116;116;116 15:59:51 INFO - PROCESS | 1678 | |1;audio-beat-detection;154;121;145;195;143;142;141;126;172;120 15:59:51 INFO - PROCESS | 1678 | |2;audio-dft;198;196;208;202;198;193;195;196;200;197 15:59:51 INFO - PROCESS | 1678 | |3;audio-fft;69;82;73;141;57;57;59;69;129;60 15:59:51 INFO - PROCESS | 1678 | |4;audio-oscillator;79;83;126;76;84;95;149;121;117;159 15:59:51 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;86;89;85;109;96;136;132;137;119 15:59:51 INFO - PROCESS | 1678 | |6;imaging-darkroom;97;100;154;95;96;95;94;94;94;93 15:59:51 INFO - PROCESS | 1678 | |7;imaging-desaturate;125;105;81;130;145;92;96;135;134;119 15:59:51 INFO - PROCESS | 1678 | |8;json-parse-financial;59;67;64;90;97;97;97;81;64;64 15:59:51 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;64;65;73;73;94;110;68;65;68;67 15:59:51 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;83;81;80;82;80;80;91;112;77 15:59:51 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;147;130;151;150;153;140;127;126;168;170 15:59:51 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;166;167;165;167;166;168;163;186;152;229 15:59:51 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;64;69;67;67;67;69;67;68;69;68 15:59:51 INFO - PROCESS | 1678 | __end_tp_report 15:59:51 INFO - PROCESS | 1678 | __start_cc_report 15:59:51 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1052 15:59:51 INFO - PROCESS | 1678 | __end_cc_report 15:59:51 INFO - PROCESS | 1678 | __startTimestamp1467932391558__endTimestamp 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | ------- Summary: start ------- 15:59:51 INFO - PROCESS | 1678 | Number of tests: 14 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:117.30 Median:116.00 stddev:4.90 (4.2%) stddev-sans-first:5.13 15:59:51 INFO - PROCESS | 1678 | Values: 115.0 114.0 116.0 117.0 117.0 131.0 115.0 116.0 116.0 116.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:145.90 Median:144.00 stddev:23.32 (16.2%) stddev-sans-first:24.55 15:59:51 INFO - PROCESS | 1678 | Values: 154.0 121.0 145.0 195.0 143.0 142.0 141.0 126.0 172.0 120.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:198.30 Median:198.00 stddev:4.24 (2.1%) stddev-sans-first:4.50 15:59:51 INFO - PROCESS | 1678 | Values: 198.0 196.0 208.0 202.0 198.0 193.0 195.0 196.0 200.0 197.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:79.60 Median:64.50 stddev:30.39 (47.1%) stddev-sans-first:32.00 15:59:51 INFO - PROCESS | 1678 | Values: 69.0 82.0 73.0 141.0 57.0 57.0 59.0 69.0 129.0 60.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:77.50 stddev:29.97 (38.7%) stddev-sans-first:29.77 15:59:51 INFO - PROCESS | 1678 | Values: 79.0 83.0 126.0 76.0 84.0 95.0 149.0 121.0 117.0 159.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:107.70 Median:85.50 stddev:21.71 (25.4%) stddev-sans-first:21.82 15:59:51 INFO - PROCESS | 1678 | Values: 88.0 86.0 89.0 85.0 109.0 96.0 136.0 132.0 137.0 119.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:101.20 Median:94.50 stddev:18.66 (19.7%) stddev-sans-first:19.73 15:59:51 INFO - PROCESS | 1678 | Values: 97.0 100.0 154.0 95.0 96.0 95.0 94.0 94.0 94.0 93.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:116.20 Median:140.00 stddev:21.43 (15.3%) stddev-sans-first:22.49 15:59:51 INFO - PROCESS | 1678 | Values: 125.0 105.0 81.0 130.0 145.0 92.0 96.0 135.0 134.0 119.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:78.00 Median:85.50 stddev:16.01 (18.7%) stddev-sans-first:15.43 15:59:51 INFO - PROCESS | 1678 | Values: 59.0 67.0 64.0 90.0 97.0 97.0 97.0 81.0 64.0 64.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:74.70 Median:68.00 stddev:15.19 (22.3%) stddev-sans-first:15.61 15:59:51 INFO - PROCESS | 1678 | Values: 64.0 65.0 73.0 73.0 94.0 110.0 68.0 65.0 68.0 67.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:81.50 stddev:10.20 (12.5%) stddev-sans-first:10.80 15:59:51 INFO - PROCESS | 1678 | Values: 83.0 83.0 81.0 80.0 82.0 80.0 80.0 91.0 112.0 77.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:150.50 stddev:15.65 (10.4%) stddev-sans-first:16.59 15:59:51 INFO - PROCESS | 1678 | Values: 147.0 130.0 151.0 150.0 153.0 140.0 127.0 126.0 168.0 170.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.90 Median:167.00 stddev:21.36 (12.8%) stddev-sans-first:22.51 15:59:51 INFO - PROCESS | 1678 | Values: 166.0 167.0 165.0 167.0 166.0 168.0 163.0 186.0 152.0 229.0 15:59:51 INFO - PROCESS | 1678 | 15:59:51 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.51 (2.2%) stddev-sans-first:0.93 15:59:51 INFO - PROCESS | 1678 | Values: 64.0 69.0 67.0 67.0 67.0 69.0 67.0 68.0 69.0 68.0 15:59:51 INFO - PROCESS | 1678 | -------- Summary: end -------- 15:59:51 INFO - PROCESS | 1678 | 15:59:52 INFO - TEST-INFO | 1678: exit 0 15:59:52 INFO - TEST-OK | kraken | took 59883ms 15:59:52 INFO - SUITE-END | took 1169s 15:59:52 INFO - Completed test suite (00:19:29) 15:59:52 INFO - javascript benchmark 15:59:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3609.1518493154113, 3661.8901432957014, 3689.409694448889, 3697.963020369797, 3723.1809002019563, 5861.443162899518, 5876.030454974929, 5876.941230587688, 5880.7059647017695, 5931.85170370741, 5908.88182236355, 5911.704414779266, 5928.6739229342365, 5949.553783466246, 5961.433663801943, 5334.226537152111, 5344.973275133619, 5346.973265133669, 5396.568274538027, 5530.281063461744, 5304.416514183436, 5386.757595908193, 5419.566434685235, 5423.83728488144, 5465.480779325978, 5386.973065134669, 5401.756920938547, 5403.648762830403, 5415.972920135414, 5428.0, 4186.958130418688, 5407.783688652469, 5428.75570599324, 5451.127819548893, 5493.395726470085, 5283.788648454057, 5363.946360536423, 5365.275687782138, 5405.432429594875, 5405.945940540583, 5823.970880145572, 5825.533957283407, 5855.795047173371, 5860.472557469848, 5872.794452194153, 6178.907316390258, 6246.843828904268, 6256.405641464054, 6257.061440783873, 6294.653794041325, 5218.530332270114, 6219.689015549205, 6231.532635052344, 6242.781502647385, 6256.718447669866, 5862.794802181903, 5871.5596330274975, 5921.437463441052, 5930.495907847881, 5931.377205393414, 6237.064440333987, 6256.5307601930035, 6317.210348706411, 6349.555531112777, 6380.425761681471, 6224.9417599008275, 6238.220222472191, 6240.251169859646, 6241.313455519889, 6258.968705156445, 6233.065040244, 6294.874102517924, 6299.874002519924, 6304.05439184126, 6313.43179113882, 6168.753249870045, 6214.192155019909, 6240.812775616739, 6249.281332646713, 6267.1539342189135, 6203.286622038523, 6211.844703882349, 6235.96882015587, 6236.501079913596, 6250.3749625037135, 4938.185199442052, 4995.9500404996215, 5090.592752579785, 5101.132807422747, 5109.284700141983, 3865.7100717446306, 4551.977240113778, 4587.655925805511, 4638.095571363552, 4646.628269738413, 5057.671251368649, 6118.510519158456, 6123.112148738497, 6161.599496032743, 6166.0, 6229.470495007975, 6243.094751261133, 6251.781187658501, 6279.874402511924, 6302.243730752339, 6016.097585362143, 6111.591738512148, 6171.506279497629, 6181.0, 6197.4732147767045, 4865.854024379274, 5000.249962505581, 5287.995280896617, 5587.245721827582, 5617.129344951539, 6484.124643173205, 6598.406143447209, 6737.562058466184, 6744.865102697919, 6748.662566871637, 6261.718222680081, 6283.7800676976085, 6286.18279623646, 6299.779507717208, 6315.021171718391, 6738.056672065817, 6760.830979225362, 6761.898571521333, 6762.661866906733, 6767.0, 6203.503719702323, 6229.127922091002, 6246.6876656167915, 6247.312795592572, 6261.8747625046335, 6278.591891527036, 6283.5601507895835, 6288.811335659938, 6294.748210071729, 6295.842603934938, 6249.218847644044, 6252.343503932204, 6267.905981410191, 6268.404501572343, 6268.655223962726, 6045.365236650265, 6138.9095594588325, 6211.751529938932, 6251.937480625317, 6283.277423096402, 6099.817005489843, 6107.144999700135, 6114.052321890114, 6117.327094019565, 6168.629882207082, 6140.048292514667, 6189.721462534107, 6265.185525881606, 6280.937190628035, 6295.244570651551, 6024.126501657148, 6135.84660383494, 6186.19579454668, 6205.0, 6214.72033758491], "value": 5836.493791697334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.1277606933182, 561.3151954615367, 562.7130163616556, 579.2585490572068, 603.9280277507423, 38651.0, 39530.80234598827, 39649.40525892107, 39668.20663586734, 39763.40354894671, 41193.0, 41722.37416438756, 41761.0, 41824.37263441051, 41907.790461047654, 8871.600777964975, 9419.246460283195, 9668.178204852578, 9898.90101098987, 9909.207263418944, 9544.47505387207, 9611.183049440771, 9753.0, 9773.462459564722, 9792.21662267017, 9738.415695058318, 9760.121589056984, 9791.265655075862, 9793.755156121082, 9825.754356141082, 9750.219982401391, 9756.414615123116, 9790.804183916352, 9794.412335259907, 9825.0, 9757.90242097577, 9802.901970980342, 9881.456519891402, 9907.900920990769, 9912.355696879751, 39941.60058399437, 39977.80011099955, 40229.0, 40276.0, 40393.99015024619, 3329.6004479462376, 3354.194993201638, 3449.292894956528, 3465.705415039725, 3495.702865256431, 28390.148295551167, 29518.55722164169, 29580.260493487618, 29935.0, 30124.397512049636, 2401.903923843044, 2537.796976241896, 2841.7442430181177, 2880.985595072032, 2913.67949525552, 420905.79094208975, 445094.0, 473383.0, 478445.0, 481338.0, 37324.81337593349, 55215.72392138014, 61613.0, 61706.69146654238, 61746.765064698455, 30795.69204307928, 36255.093622659646, 36649.267014660094, 36713.81643091821, 36865.44701829475, 16414.015159090493, 16488.422905198262, 16655.41706040283, 16657.91671041637, 16700.58248543796, 13947.302634868216, 14150.646233844236, 14151.504697335544, 14168.645783855485, 14193.290335483185, 8106.675732970733, 8169.550674712829, 8339.332853371716, 8492.320614350838, 8508.65965361391, 3583.5699716033723, 3590.2101537661674, 3618.2401695643684, 3620.094976255936, 3636.1818590816856, 1055.7624534479835, 1081.1837063017372, 1081.3403823667556, 1085.8273065089843, 1087.211771465681, 31898.84050579732, 31974.360512789615, 32000.839995799874, 32215.194620134684, 32657.69369225252, 1189.2032338333338, 1191.576990168495, 1221.0841868598552, 1274.2354587247762, 1356.1930651262483, 15873.761893571605, 16095.678086438205, 16215.0, 16244.269007894673, 16515.421960231575, 661011.0, 670261.0, 739873.0, 755669.0, 755849.0, 63634.68182659057, 63947.36052639414, 64611.353886461475, 64690.0, 64888.675556621914, 1567.5924259692333, 1576.7398379267522, 1578.6921550297582, 1583.0580804421352, 1586.1197035645328, 24152.134427759003, 30553.0, 30635.08094757161, 30956.0, 31123.84438077795, 56065.719671401384, 56319.0, 56595.71702141463, 56693.43306566882, 56875.14687279611, 585743.0, 587944.0, 592951.0, 603456.0, 605313.0, 27869.860650696617, 28077.859610701817, 28570.42859142764, 28675.13974580766, 28987.5651865218, 37767.81116094402, 47305.29042064441, 47592.52407475881, 47945.76027119842, 48802.0, 37110.886673399844, 37683.223843131396, 37841.81079094587, 37901.620983789806, 38067.04832379213, 37613.87158385253, 37642.0, 37692.0, 37800.62199377971, 38095.42856857094, 32802.19587922592, 38014.80992595019, 39032.0, 39805.80097099496, 39893.80318590447, 31249.531257031616, 32694.509582355808, 33033.50449743304, 33037.66962330442, 33085.66914330826, 25068.24795256145, 25275.49449011046, 25441.236762897144, 25670.358241043377, 25679.0], "value": 19241.911560676464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.5931055494234, 415.96464300534456, 417.0408061458645, 423.2550710749081, 426.1285670803207, 20351.0, 20952.580948381023, 21100.472488187803, 21126.943652817376, 22044.448888777788, 21725.782742172574, 21907.561848763016, 22247.44381390462, 22455.775442245573, 22803.77196228037, 5542.946840100378, 6194.411530904579, 6249.218847644044, 6274.1529893464485, 6279.560430769848, 6019.0, 6176.567640265183, 6189.978653522164, 6193.380661933793, 6216.751329946796, 5169.974150129244, 5859.970700146493, 6034.4568988791, 6140.201773769404, 6169.383061693818, 5431.538319242869, 5862.208601838761, 5932.406519654849, 5975.581709280352, 6000.189974353472, 5238.816641417532, 5372.7045012524295, 5383.838484845422, 5398.055340315429, 5413.891722165574, 22185.11259549616, 27105.322366940985, 27379.0, 27396.45207095847, 27602.723972760217, 2302.7697230277004, 2350.612148995414, 2397.280815755284, 2466.025919761702, 2737.2609395463114, 15369.154696491689, 15794.763078553831, 15978.840211597852, 16026.118563479004, 16389.426370077108, 1778.1820362633205, 1837.5130590393555, 1864.2449807827852, 1897.155765684271, 1926.8747531410413, 103669.0, 113141.43429282884, 113461.0, 115704.0, 117445.41277293558, 12049.939750301193, 12208.877911220952, 12232.204906681216, 12270.079744019235, 12315.99999999982, 15041.849581504264, 15050.473233436776, 15107.244637768068, 15477.0, 15490.612734681497, 7978.5611791350875, 8421.073681894986, 9271.258299336172, 9349.90650093504, 9442.055794420641, 9272.907270927339, 9293.907060929305, 9358.315503209487, 9363.297752668577, 9421.010793866682, 4242.0, 4782.067496838084, 4839.564439200489, 4864.610831133501, 4887.462379138292, 1771.8305918093997, 2014.6831144184305, 2125.234915430444, 2146.828253739697, 2150.720406347165, 932.8181004704153, 1023.513830930317, 1024.8718910136083, 1080.7514271717391, 1094.9726256843483, 20329.695054574193, 20837.270695525585, 20899.47751306199, 20907.790922090586, 21211.575768484545, 948.2508818033814, 957.7740492170034, 1057.619257067455, 1067.4609322292192, 1098.8296813993843, 8747.956260218658, 9206.26349892007, 10668.786624267626, 10786.46067696612, 10856.511456984455, 641917.0, 659274.0, 659398.0, 682042.0, 691512.5424372846, 72127.0, 112954.0, 113602.0, 115332.0, 129391.35304323418, 1052.4737631184407, 1082.3181395720803, 1088.8257878739523, 1089.84742136101, 1092.6503518874042, 15084.547463576111, 16481.505554833373, 18983.810161898204, 19469.51326216856, 19476.0, 54150.916981660936, 55747.60630984258, 55874.44125558692, 56369.43630563642, 57272.140917887096, 79322.2067779338, 82376.0, 82843.0, 82923.58538207512, 84770.0, 8042.9597852010365, 8325.0, 8498.830023399374, 8506.234438900528, 8517.616707248064, 11196.832047519456, 12382.504699811907, 12524.060695447695, 12648.620541383772, 12988.895943844502, 10744.0, 11140.498677559368, 11155.27490713101, 11199.377257938755, 11208.439578021229, 8849.557522123996, 9191.908080919105, 9261.768455788659, 11029.779404412027, 11341.149413794163, 11196.776064478501, 11678.70803229926, 11784.58753943608, 11810.40947952616, 11923.0461563073, 8097.919020809953, 8234.958825206075, 8425.115362887054, 8585.055643879043, 8636.0, 8435.072142064246, 9960.850587241343, 10721.445390418501, 10972.0, 11938.164328496921], "value": 9908.232568481166, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1656.8591669708073, 1683.6969345517805, 1989.6020795840827, 2029.2086086426286, 2131.872087674739, 8210.958945205266, 8882.978457477391, 8969.686060987866, 9120.8631870522, 9160.404573702714, 8942.19520243178, 8983.685571005017, 9001.054889236633, 9094.45433274004, 9115.908840911588, 2531.2785856030987, 2544.37662772621, 2564.24354815329, 2567.319660290025, 2573.369524466508, 2489.7012358516913, 2490.3151633300895, 2493.1024831060804, 2498.6252062190633, 2503.7871780898645, 2114.260008996854, 2428.720697119836, 2540.593505039194, 2570.8714564271804, 2573.4338445541953, 2534.9239522814346, 2541.8983240670445, 2566.8973241070335, 2574.9485010299877, 2582.5738753105716, 2108.68369744538, 2530.683664541932, 2559.5264875998, 2572.421205228827, 2574.4979728952862, 8960.731178064669, 9163.541822908828, 9205.723828285161, 9220.44677319363, 9225.723228303095, 5523.8066667666435, 5677.801276955287, 5680.4319568043275, 5719.857003574903, 5720.771169153229, 3126.5310203469435, 3625.1118475973553, 3699.667029967316, 3754.6295602105306, 3760.304343696425, 1064.5741703318656, 1070.82866741321, 1071.9678409647722, 1072.447689439939, 1072.8176210044232, 12020.338881361522, 12242.938785306016, 12295.631131066082, 12303.630891073282, 12324.0, 4040.373742069984, 4955.950440495549, 4961.925571116436, 5038.420581633086, 5076.0863044652315, 10383.688489345332, 10389.324693894872, 10406.0, 10439.425831579185, 10487.951204879451, 4660.440747110369, 5620.297462817148, 5642.943570564242, 5679.176519404746, 5735.942640573624, 4641.419822522184, 5045.5459008689395, 5122.154844450624, 5156.329677142023, 5228.581713462914, 4230.386593943861, 4271.508776490681, 4290.570942905747, 4365.410669559632, 4419.690621656453, 1190.9464074116513, 1420.5170242117729, 1439.5105664074265, 1449.311577000916, 1449.6955639315652, 884.4162852517436, 944.6363150187227, 973.4791886340773, 1007.9647212347533, 1018.032868774667, 5236.6857988520815, 6028.216331876828, 6036.909446358308, 6066.787662431793, 6267.592606480564, 978.3005151316701, 978.4178413843752, 1042.6142327338932, 1059.7668512927144, 1074.9193810464246, 3998.1608460108678, 4161.667066634662, 4188.706790524634, 4189.036521600049, 4259.467566554181, 10784.784304314027, 11039.558417663364, 11068.00387965087, 11235.94382028101, 11318.547258109584, 9395.0, 10976.341419514854, 11016.394098324668, 11051.336919784839, 11102.44487775608, 8185.836283274421, 8566.3146948244, 8652.0, 8716.346274029347, 8790.516521591246, 6134.754609815557, 6201.550387596827, 6258.749650014131, 6262.843428914313, 6269.3417191196095, 9938.204943604638, 10030.448325342177, 10047.497625118862, 10068.194544436574, 10134.543945522322, 9866.851997219905, 10200.0819926207, 10229.130523905551, 10360.119389851947, 10380.377177369382, 7127.893081603676, 7504.137024242282, 7722.420818438527, 7800.907872897912, 7914.525128492309, 8334.416590838584, 8514.0, 8556.18716221958, 8581.485110893367, 8604.78488037804, 7548.811279718051, 7640.465167438226, 7685.961570192113, 7711.190325016017, 7822.335101516207, 7462.888056679046, 7494.325510703845, 7509.0, 7510.211427800003, 7644.044494438195, 7174.246704096204, 7196.856062878608, 7201.459890508128, 7230.710771569078, 7235.2764723529335, 4966.130927087817, 4979.800807967786, 5077.289179514944, 5131.56381707559, 5191.299174611379, 5123.436421993503, 5133.4096578893905, 5174.6119041071315, 5204.297419848272, 5260.526552610283], "value": 4803.278995062264, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.1795875335061, 341.1233130853706, 341.7795521888382, 346.57544507977724, 349.07321062578865, 6699.899501507482, 6749.49378796591, 6760.628165450905, 6821.420179284761, 6847.246802851689, 5454.61817672763, 6876.518643694943, 6894.034835123087, 6904.0, 6905.413039891602, 5105.3873535175835, 5115.181570948649, 5119.897602047957, 5121.385433747955, 5135.922961155586, 4402.691811573175, 4863.708177509343, 5119.56483698886, 5149.665271757323, 5150.098732721777, 5081.46644602317, 5099.71951542665, 5101.642884998052, 5101.872453188663, 5123.820666276681, 4756.548127927841, 4914.16459201933, 5093.2105523643895, 5094.7197904115255, 5097.541221290083, 4152.875413737563, 4171.666266698657, 4176.665866730655, 4193.35003074524, 4209.957900420987, 6353.110564520971, 6424.421802037792, 6451.322611125811, 6462.709178086998, 6492.513061520405, 5816.272965879265, 5879.412058794129, 5885.352611212763, 5891.823245302648, 5916.3787802281, 6393.7762178324, 6822.5565338253355, 7264.600446975467, 7276.599787011713, 7277.963610181915, 4546.636269098497, 4701.059788042405, 4716.6698331116495, 4735.905281894343, 4740.360051393052, 7616.0, 7651.5409075455655, 7683.538987660702, 7726.34326082278, 7729.690812367555, 4797.496262892346, 4801.18379875422, 4814.325994360793, 4815.398075240595, 4821.325014497973, 4888.169011268093, 4890.437599676083, 4893.828715994923, 4896.069746748107, 4900.848300649344, 4832.323474713543, 5062.291279220912, 5618.887622247532, 5762.049261871828, 5856.707164641751, 7090.4327653788605, 7340.779776606711, 7346.853062938818, 7357.682330066012, 7399.334059934632, 1671.3648813450811, 1676.6814305281957, 1691.6532110917233, 1692.3991982846157, 1693.889897156681, 848.5587494502824, 1060.7242117049468, 1063.5320458998017, 1080.2492267873909, 1081.0918828184363, 6940.7917762467205, 6952.636103724758, 7018.824529386806, 7032.6132062736015, 7033.542819716702, 7216.386607138347, 7509.249075092556, 7593.088829340514, 7613.352865006536, 7639.69441222356, 7109.786706398816, 7122.5726456412785, 7137.394086330534, 7140.464465165133, 7144.142702875688, 3917.193868314574, 3960.148568057881, 3981.6814654827544, 4042.6765858731233, 4056.3104272273786, 8200.5489698066, 8250.257476827115, 8259.297959673375, 8269.0, 8276.50340979531, 6468.870622587522, 7755.991721076224, 7898.0, 7917.535255977663, 7919.366450683931, 8145.429819912668, 8197.46716463428, 8202.0, 8205.917940820635, 8227.629756660965, 7392.221353667249, 7485.70057197706, 7599.88600171009, 7602.353799927068, 7642.541447513167, 7424.96287518559, 7439.962800185965, 7449.888251676338, 7455.6644950978425, 7473.88789168152, 8161.387895907949, 8204.0, 8211.671533138608, 8244.587770611326, 8247.422680412314, 4802.159622066194, 4816.8554943351755, 4818.903621927471, 4829.830955916526, 4832.106060378841, 6550.213974323112, 7125.966734823318, 7330.633468326669, 7590.506617069873, 7606.847863042819, 6326.766280575428, 6945.583265004116, 7365.631718413951, 7382.704691812482, 7385.29839665231, 7284.781456556312, 7315.195328513752, 7326.743563975236, 7348.1182258129365, 7350.338469537767, 6264.404881536247, 7159.926011098377, 7164.355208031302, 7177.641117944187, 7184.568925864465, 6994.720211191496, 7092.858142837011, 7325.890111648223, 7338.046054012944, 7432.145303290191, 6418.0, 6580.144581204604, 6885.552439091443, 7017.508774385744, 7132.322429369202], "value": 5325.827776932996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.6190499987506, 773.7021246819976, 785.0971382909656, 798.7204478432548, 823.3536673711138, 14694.55916322512, 14803.555893323191, 15064.171470569128, 15072.698546029073, 15097.924510377446, 14270.785938210935, 14322.0, 14350.138991660482, 14365.209913454755, 14380.856191438083, 773.0993392697501, 890.8084761776216, 954.308126608207, 954.5609019850876, 974.3325821812045, 901.8737376767258, 902.8600566912139, 939.1078475448318, 944.3342443577261, 974.9908844346103, 974.3958745577752, 974.6880998080617, 1001.644416232238, 1012.9566546457124, 1048.6591857646258, 969.2246203037541, 994.6419289055934, 1021.4433133941945, 1026.9589216431334, 1042.2547878267037, 750.7747675697269, 783.6042798386778, 785.7603430953557, 786.2255678157011, 788.4283894176733, 15313.540593782205, 15317.234138293152, 15347.693046139015, 15362.0, 15464.0, 13123.934380328037, 13250.801237981437, 13302.600921972356, 13310.800337994939, 13460.932695336558, 10365.37807731531, 10392.948035259851, 10413.427261500614, 10427.113695335906, 10558.366498010144, 3141.2932090279505, 3619.059044648384, 3636.127329440915, 3686.4838922550866, 3847.9807600961817, 81741.59129204375, 82911.585442073, 84195.57902210511, 85109.87225319355, 85448.14551854464, 9712.75718107053, 9805.80388392228, 9913.950430247802, 9931.453770042717, 10155.441450720133, 22670.0, 22842.885785570965, 22844.885775571016, 22875.656865147037, 22880.855957202406, 7572.015637967139, 7633.923660763432, 7641.121271053788, 7677.0, 7720.806979825549, 4134.441850350225, 4181.121964387452, 4193.182329445729, 4195.202911446815, 4210.45264115663, 3710.8144592770254, 3714.814259287025, 3760.8683696070507, 3760.8683696070507, 3781.357169281229, 562.4488001758218, 664.0703015777854, 665.1452883045264, 680.8468094678757, 682.2836022176695, 570.1476292942078, 583.096200888621, 600.177756473634, 627.7740013595102, 633.2021652717517, 8286.751397458085, 8292.709755158541, 8382.119877412784, 8415.579221039046, 8608.42713417676, 510.2703134517601, 577.6534079552235, 627.6987046217749, 634.6319134901746, 640.9327020662856, 3386.4243078676686, 3536.9565978036026, 3744.5506539215467, 3933.3316724382544, 4007.1785284016705, 93364.0, 95219.0, 95993.04006959981, 96433.0356696424, 97181.0, 57537.712311438176, 75610.0, 76623.23376766162, 77869.22130778733, 78563.60718196486, 68787.0, 70728.0, 71111.64444177746, 72620.0, 72800.63599682074, 6774.491913106438, 7697.961510192637, 7954.862912559374, 8039.1156972734125, 8041.67833286662, 45875.311870321304, 46117.76941115273, 47240.763796182175, 47256.81857953441, 47954.28068578905, 59761.40238597558, 61061.77876442357, 61966.380336197864, 62647.6867615659, 62992.055119172335, 9134.177923986874, 10238.078572928473, 10423.843642345219, 10620.09729173029, 10698.06643529995, 10995.285306455055, 11075.833862491907, 11153.219274650697, 11297.378644174649, 11608.361540115375, 10497.895021049691, 10701.678949631523, 10953.780924381308, 10962.177836662122, 11101.389423581457, 10340.0, 10606.098481629147, 10615.681529554126, 10651.30766500175, 10911.018008379284, 10319.019693129141, 10322.071013608811, 10571.62999295021, 10605.204609654462, 11043.337399756041, 8968.327375446737, 9204.677836275698, 9231.35380523357, 9370.10983956523, 9703.708888733348, 9781.070798274153, 9861.506924653595, 9931.702048938543, 10035.34770239932, 10113.64602238918], "value": 6951.8222237810505, "unit": "score"}], "name": "dromaeo_css", "value": 7633.827098223983, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 116.0, 117.0, 117.0, 131.0, 115.0, 116.0, 116.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 121.0, 145.0, 195.0, 143.0, 142.0, 141.0, 126.0, 172.0, 120.0], "value": 145.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 208.0, 202.0, 198.0, 193.0, 195.0, 196.0, 200.0, 197.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 73.0, 141.0, 57.0, 57.0, 59.0, 69.0, 129.0, 60.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 126.0, 76.0, 84.0, 95.0, 149.0, 121.0, 117.0, 159.0], "value": 108.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 89.0, 85.0, 109.0, 96.0, 136.0, 132.0, 137.0, 119.0], "value": 107.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 100.0, 154.0, 95.0, 96.0, 95.0, 94.0, 94.0, 94.0, 93.0], "value": 101.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 105.0, 81.0, 130.0, 145.0, 92.0, 96.0, 135.0, 134.0, 119.0], "value": 116.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 67.0, 64.0, 90.0, 97.0, 97.0, 97.0, 81.0, 64.0, 64.0], "value": 78.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 73.0, 73.0, 94.0, 110.0, 68.0, 65.0, 68.0, 67.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 80.0, 82.0, 80.0, 80.0, 91.0, 112.0, 77.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 130.0, 151.0, 150.0, 153.0, 140.0, 127.0, 126.0, 168.0, 170.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 165.0, 167.0, 166.0, 168.0, 163.0, 186.0, 152.0, 229.0], "value": 172.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 67.0, 67.0, 67.0, 69.0, 67.0, 68.0, 69.0, 68.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1599.3000000000004, "alertThreshold": 2.0}]} 15:59:52 INFO - Return code: 0 15:59:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:59:52 ERROR - # TBPL SUCCESS # 15:59:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:59:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:59:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:59:52 INFO - 2016-07-07 15:59:52.891 screenresolution[1683:10710] starting screenresolution argv=screenresolution get 15:59:52 INFO - 2016-07-07 15:59:52.894 screenresolution[1683:10710] Display 0: 1600x1200x32@60 15:59:52 INFO - 2016-07-07 15:59:52.900 screenresolution[1684:10713] starting screenresolution argv=screenresolution list 15:59:52 INFO - Available Modes on Display 0 15:59:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:59:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:59:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:59:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:59:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:59:53 INFO - Intel Iris: 15:59:53 INFO - Chipset Model: Intel Iris 15:59:53 INFO - Type: GPU 15:59:53 INFO - Bus: Built-In 15:59:53 INFO - VRAM (Dynamic, Max): 1536 MB 15:59:53 INFO - Vendor: Intel (0x8086) 15:59:53 INFO - Device ID: 0x0a2e 15:59:53 INFO - Revision ID: 0x0009 15:59:53 INFO - Displays: 15:59:53 INFO - Display: 15:59:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:59:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:59:53 INFO - Display Serial Number: 1600x1200 60 15:59:53 INFO - Main Display: Yes 15:59:53 INFO - Mirror: Off 15:59:53 INFO - Online: Yes 15:59:53 INFO - Rotation: Supported 15:59:53 INFO - Return code: 0 15:59:53 INFO - Running post-action listener: _resource_record_post_action 15:59:53 INFO - Running post-run listener: _resource_record_post_run 15:59:54 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 31804928; Write bytes: 496468992; Read time: 196; Write time: 1571 15:59:54 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185051648; Write bytes: 186082816; Read time: 16546; Write time: 415 15:59:54 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 30879232; Write bytes: 300432896; Read time: 184; Write time: 1126 15:59:54 INFO - Running post-run listener: _upload_blobber_files 15:59:54 INFO - Blob upload gear active. 15:59:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:59:54 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:59:54 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:59:54 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:59:54 INFO - (blobuploader) - INFO - Open directory for files ... 15:59:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:59:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:59:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:55 INFO - (blobuploader) - INFO - Done attempting. 15:59:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:59:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:59:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:59:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:59:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:59:56 INFO - (blobuploader) - INFO - Done attempting. 15:59:56 INFO - (blobuploader) - INFO - Iteration through files over. 15:59:56 INFO - Return code: 0 15:59:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:59:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:59:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5b93997b95091eb2c454d06b23c5e58194cc2a42ce3dd52d9db1c37e2bb2233dd3bb2eb011470b5d63ef1d6bb68460388365b68c21f0b2a984e3b032b9e1b62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34663b73336f0aebf6d4b5fda5ee3f79e87413f35febf39e880df8ce866d82772772366404e2b84357ee61449bd7da2ba0297875ee1950eb77c15fc763a5defa"} 15:59:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:59:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:59:56 INFO - Contents: 15:59:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5b93997b95091eb2c454d06b23c5e58194cc2a42ce3dd52d9db1c37e2bb2233dd3bb2eb011470b5d63ef1d6bb68460388365b68c21f0b2a984e3b032b9e1b62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34663b73336f0aebf6d4b5fda5ee3f79e87413f35febf39e880df8ce866d82772772366404e2b84357ee61449bd7da2ba0297875ee1950eb77c15fc763a5defa"} 15:59:56 INFO - Running post-run listener: copy_logs_to_upload_dir 15:59:56 INFO - Copying logs to upload dir... 15:59:56 INFO - mkdir: /builds/slave/test/build/upload/logs 15:59:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.209342 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-07 15:59:56.357996) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 15:59:56.361475) ========= 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.dMWNwrPpGa/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.6gpcLEKInC/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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/Mozilla-Beta/sha512/c5b93997b95091eb2c454d06b23c5e58194cc2a42ce3dd52d9db1c37e2bb2233dd3bb2eb011470b5d63ef1d6bb68460388365b68c21f0b2a984e3b032b9e1b62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34663b73336f0aebf6d4b5fda5ee3f79e87413f35febf39e880df8ce866d82772772366404e2b84357ee61449bd7da2ba0297875ee1950eb77c15fc763a5defa"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011374 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-beta-macosx64/1467815638/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c5b93997b95091eb2c454d06b23c5e58194cc2a42ce3dd52d9db1c37e2bb2233dd3bb2eb011470b5d63ef1d6bb68460388365b68c21f0b2a984e3b032b9e1b62", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/34663b73336f0aebf6d4b5fda5ee3f79e87413f35febf39e880df8ce866d82772772366404e2b84357ee61449bd7da2ba0297875ee1950eb77c15fc763a5defa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 15:59:56.393839) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:59:56.394211) ========= 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.dMWNwrPpGa/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.6gpcLEKInC/Listeners TMPDIR=/var/folders/qw/0zz61d_n6_s8yy9116jp1djc00000w/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.005263 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 15:59:56.442731) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 15:59:56.443073) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 15:59:56.443469) ========= ========= Total master_lag: 0.20 =========