builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0192 starttime: 1487282739.08 results: success (0) buildid: 20170216105119 builduid: af369f3d3eb44e6ba0b6c22d14a20ce6 revision: 820bc5bd3120853d611af1056f4a2b35528bb927 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.082414) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.082901) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.083175) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.110483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.110879) ========= 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.vga8ByllxD/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.UJu5SOj9xf/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 --2017-02-16 14:05:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.86M=0.001s 2017-02-16 14:05:39 (8.86 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.344076 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.481867) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.482432) ========= 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.vga8ByllxD/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.UJu5SOj9xf/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.027993 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:39.533333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-16 14:05:39.533694) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 820bc5bd3120853d611af1056f4a2b35528bb927 --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 820bc5bd3120853d611af1056f4a2b35528bb927 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vga8ByllxD/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.UJu5SOj9xf/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 2017-02-16 14:05:39,637 truncating revision to first 12 chars 2017-02-16 14:05:39,637 Setting DEBUG logging. 2017-02-16 14:05:39,637 attempt 1/10 2017-02-16 14:05:39,637 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/820bc5bd3120?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-16 14:05:40,848 unpacking tar archive at: mozilla-beta-820bc5bd3120/testing/mozharness/ program finished with exit code 0 elapsedTime=1.457900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-16 14:05:41.015568) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:41.015886) ========= script_repo_revision: 820bc5bd3120853d611af1056f4a2b35528bb927 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:41.016298) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:41.016593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-16 14:05:41.037080) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-16 14:05:41.037488) ========= /tools/buildbot/bin/python -u 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', '-u', '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.vga8ByllxD/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.UJu5SOj9xf/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:05:41 INFO - MultiFileLogger online at 20170216 14:05:41 in /builds/slave/test 14:05:41 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 14:05:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:41 INFO - {'append_to_log': False, 14:05:41 INFO - 'base_work_dir': '/builds/slave/test', 14:05:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:05:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:41 INFO - 'branch': 'Mozilla-Beta', 14:05:41 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:41 INFO - 'config_files': ('talos/mac_config.py',), 14:05:41 INFO - 'default_actions': ('clobber', 14:05:41 INFO - 'read-buildbot-config', 14:05:41 INFO - 'download-and-extract', 14:05:41 INFO - 'populate-webroot', 14:05:41 INFO - 'create-virtualenv', 14:05:41 INFO - 'install', 14:05:41 INFO - 'run-tests'), 14:05:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:41 INFO - 'download_minidump_stackwalk': True, 14:05:41 INFO - 'download_symbols': 'ondemand', 14:05:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:41 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:41 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:41 INFO - 'installer_path': 'installer.exe', 14:05:41 INFO - 'log_level': 'info', 14:05:41 INFO - 'log_name': 'talos', 14:05:41 INFO - 'log_to_console': True, 14:05:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:05:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:05:41 INFO - 'opt_config_files': (), 14:05:41 INFO - 'pip_index': False, 14:05:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:41 INFO - 'cmd': ('bash', 14:05:41 INFO - '-c', 14:05:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:41 INFO - 'enabled': True, 14:05:41 INFO - 'halt_on_failure': False, 14:05:41 INFO - 'name': 'check_screen_resolution'},), 14:05:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:41 INFO - 'cmd': ('bash', 14:05:41 INFO - '-c', 14:05:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:41 INFO - 'enabled': True, 14:05:41 INFO - 'halt_on_failure': False, 14:05:41 INFO - 'name': 'check_screen_resolution'},), 14:05:41 INFO - 'run_cmd_checks_enabled': True, 14:05:41 INFO - 'sps_profile': False, 14:05:41 INFO - 'sps_profile_interval': 0, 14:05:41 INFO - 'suite': 'dromaeojs-e10s', 14:05:41 INFO - 'system_bits': '32', 14:05:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:41 INFO - 'title': 't-yosemite-r7-0192', 14:05:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:41 INFO - 'use_talos_json': True, 14:05:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:41 INFO - 'work_dir': 'build'} 14:05:41 INFO - [mozharness: 2017-02-16 22:05:41.255122Z] Running clobber step. 14:05:41 INFO - Running pre-action listener: _resource_record_pre_action 14:05:41 INFO - Running main action method: clobber 14:05:41 INFO - rmtree: /builds/slave/test/build 14:05:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:43 INFO - Running post-action listener: _resource_record_post_action 14:05:43 INFO - [mozharness: 2017-02-16 22:05:43.786322Z] Finished clobber step (success) 14:05:43 INFO - [mozharness: 2017-02-16 22:05:43.786451Z] Running read-buildbot-config step. 14:05:43 INFO - Running pre-action listener: _resource_record_pre_action 14:05:43 INFO - Running main action method: read_buildbot_config 14:05:43 INFO - Using buildbot properties: 14:05:43 INFO - { 14:05:43 INFO - "project": "", 14:05:43 INFO - "product": "firefox", 14:05:43 INFO - "script_repo_revision": "production", 14:05:43 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 14:05:43 INFO - "repository": "", 14:05:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 14:05:43 INFO - "buildid": "20170216105119", 14:05:43 INFO - "pgo_build": "False", 14:05:43 INFO - "basedir": "/builds/slave/test", 14:05:43 INFO - "buildnumber": 27, 14:05:43 INFO - "slavename": "t-yosemite-r7-0192", 14:05:43 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 14:05:43 INFO - "platform": "yosemite_r7", 14:05:43 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 14:05:43 INFO - "branch": "mozilla-beta", 14:05:43 INFO - "repo_path": "releases/mozilla-beta", 14:05:43 INFO - "revision": "820bc5bd3120853d611af1056f4a2b35528bb927", 14:05:43 INFO - "stage_platform": "macosx64", 14:05:43 INFO - "builduid": "af369f3d3eb44e6ba0b6c22d14a20ce6", 14:05:43 INFO - "slavebuilddir": "test" 14:05:43 INFO - } 14:05:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 14:05:43 INFO - Running post-action listener: _resource_record_post_action 14:05:43 INFO - [mozharness: 2017-02-16 22:05:43.789797Z] Finished read-buildbot-config step (success) 14:05:43 INFO - [mozharness: 2017-02-16 22:05:43.789912Z] Running download-and-extract step. 14:05:43 INFO - Running pre-action listener: _resource_record_pre_action 14:05:43 INFO - Running main action method: download_and_extract 14:05:43 INFO - mkdir: /builds/slave/test/build/tests 14:05:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:43 INFO - trying https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 14:05:43 INFO - Downloading https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 14:05:45 INFO - Downloaded 1165 bytes. 14:05:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 14:05:45 INFO - Using the following test package requirements: 14:05:45 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:05:45 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 14:05:45 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 14:05:45 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 14:05:45 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 14:05:45 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 14:05:45 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 14:05:45 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 14:05:45 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 14:05:45 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 14:05:45 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 14:05:45 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 14:05:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:05:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:05:45 INFO - Fetch https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:05:45 INFO - Http code: 200 14:05:45 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 14:05:45 INFO - x-amz-cf-id: lUSh-MfJzWcvncnbOOUo8La-WS0yhhDLDrVz94BH_Nzc3aduDgciIg== 14:05:45 INFO - x-amz-version-id: NRXE6zsJJmRgEB5I_FDsW2e6DihbvqfK 14:05:46 INFO - Expected file size: 16093123 14:05:46 INFO - Obtained file size: 16093123 14:05:52 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 14:05:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 14:05:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 14:05:52 INFO - Fetch https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 14:05:53 INFO - Http code: 200 14:05:53 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 14:05:53 INFO - x-amz-cf-id: MkuSEaexYFSKPTmyBgjbbqJyj67K6cgXcV0FUgynLFJ3HtExxDOxyA== 14:05:53 INFO - x-amz-version-id: NRXE6zsJJmRgEB5I_FDsW2e6DihbvqfK 14:05:53 INFO - Expected file size: 16093123 14:05:53 INFO - Obtained file size: 16093123 14:06:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 14:06:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 14:06:00 INFO - Fetch https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 14:06:01 INFO - Http code: 200 14:06:01 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 14:06:01 INFO - x-amz-cf-id: 3Rzzd91Cx7yA5IWkIQ4-nu1Iuvs3PbA-s-KOCrWzIPcSOROKSVw2ig== 14:06:01 INFO - x-amz-version-id: vc7YdttEJ7azJ7jnn9TwLPdfcPaPDm5b 14:06:01 INFO - Expected file size: 14403005 14:06:01 INFO - Obtained file size: 14403005 14:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:01 INFO - trying https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:06:01 INFO - Downloading https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 14:06:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 14:06:04 INFO - Downloaded 82137548 bytes. 14:06:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:06:04 INFO - mkdir: /builds/slave/test/properties 14:06:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:04 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:04 INFO - Contents: 14:06:04 INFO - build_url:https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg 14:06:04 INFO - Running post-action listener: _resource_record_post_action 14:06:04 INFO - Running post-action listener: set_extra_try_arguments 14:06:04 INFO - [mozharness: 2017-02-16 22:06:04.917196Z] Finished download-and-extract step (success) 14:06:04 INFO - [mozharness: 2017-02-16 22:06:04.917355Z] Running populate-webroot step. 14:06:04 INFO - Running pre-action listener: _resource_record_pre_action 14:06:04 INFO - Running main action method: populate_webroot 14:06:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:04 INFO - '--tppagecycles', 14:06:04 INFO - '7'], 14:06:04 INFO - 'tests': ['tsvgm']}}, 14:06:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['damp', 'tps']}, 14:06:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'tests': ['damp', 'tps']}, 14:06:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['dromaeo_dom']}, 14:06:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['basic_compositor_video']}, 14:06:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:06:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['a11yr', 14:06:04 INFO - 'ts_paint', 14:06:04 INFO - 'tpaint', 14:06:04 INFO - 'sessionrestore', 14:06:04 INFO - 'sessionrestore_no_auto_restore', 14:06:04 INFO - 'tabpaint']}, 14:06:04 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:04 INFO - 'ts_paint', 14:06:04 INFO - 'tpaint', 14:06:04 INFO - 'sessionrestore', 14:06:04 INFO - 'sessionrestore_no_auto_restore', 14:06:04 INFO - 'tabpaint']}, 14:06:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:04 INFO - 'ts_paint', 14:06:04 INFO - 'tpaint', 14:06:04 INFO - 'sessionrestore', 14:06:04 INFO - 'sessionrestore_no_auto_restore', 14:06:04 INFO - 'tabpaint']}, 14:06:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:04 INFO - 'ts_paint', 14:06:04 INFO - 'tpaint', 14:06:04 INFO - 'sessionrestore', 14:06:04 INFO - 'sessionrestore_no_auto_restore', 14:06:04 INFO - 'tabpaint']}, 14:06:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['a11yr', 14:06:04 INFO - 'ts_paint', 14:06:04 INFO - 'tpaint', 14:06:04 INFO - 'sessionrestore', 14:06:04 INFO - 'sessionrestore_no_auto_restore', 14:06:04 INFO - 'tabpaint']}, 14:06:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['a11yr', 14:06:04 INFO - 'ts_paint', 14:06:04 INFO - 'tpaint', 14:06:04 INFO - 'sessionrestore', 14:06:04 INFO - 'sessionrestore_no_auto_restore', 14:06:04 INFO - 'tabpaint']}, 14:06:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['tsvgx', 14:06:04 INFO - 'tsvgr_opacity', 14:06:04 INFO - 'tart', 14:06:04 INFO - 'tscrollx', 14:06:04 INFO - 'cart']}, 14:06:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:04 INFO - 'tsvgr_opacity', 14:06:04 INFO - 'tart', 14:06:04 INFO - 'tscrollx', 14:06:04 INFO - 'cart']}, 14:06:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'talos_options': ['--disable-e10s'], 14:06:04 INFO - 'tests': ['tp5o']}, 14:06:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'tests': ['tp5o']}, 14:06:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'talos_options': ['--disable-e10s', 14:06:04 INFO - '--xperf_path', 14:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:04 INFO - 'tests': ['tp5n']}, 14:06:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:04 INFO - 'talos_options': ['--xperf_path', 14:06:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:04 INFO - 'tests': ['tp5n']}}, 14:06:04 INFO - 'talos.zip': {'path': '', 14:06:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:04 INFO - Running post-action listener: _resource_record_post_action 14:06:04 INFO - [mozharness: 2017-02-16 22:06:04.935982Z] Finished populate-webroot step (success) 14:06:04 INFO - [mozharness: 2017-02-16 22:06:04.936091Z] Running create-virtualenv step. 14:06:04 INFO - Running pre-action listener: _resource_record_pre_action 14:06:04 INFO - Running main action method: create_virtualenv 14:06:04 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:04 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 14:06:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:05 INFO - Using real prefix '/tools/python27' 14:06:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:05 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:08 INFO - Installing pip.................done. 14:06:08 INFO - Return code: 0 14:06:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:06:08 INFO - Reading from file tmpfile_stdout 14:06:08 INFO - Output received: 14:06:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:06:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:08 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 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:08 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 14:06:08 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 14:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:08 INFO - 'HOME': '/Users/cltbld', 14:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:08 INFO - 'LOGNAME': 'cltbld', 14:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:08 INFO - 'MOZ_NO_REMOTE': '1', 14:06:08 INFO - 'NO_EM_RESTART': '1', 14:06:08 INFO - 'PAGER': '/bin/cat', 14:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:08 INFO - 'PWD': '/builds/slave/test', 14:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:08 INFO - 'SHELL': '/bin/bash', 14:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:08 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:08 INFO - 'USER': 'cltbld', 14:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:08 INFO - 'XPC_FLAGS': '0x0', 14:06:08 INFO - 'XPC_SERVICE_NAME': '0', 14:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:09 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 14:06:09 INFO - Cleaning up... 14:06:09 INFO - Return code: 0 14:06:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:06:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:09 INFO - 'HOME': '/Users/cltbld', 14:06:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:09 INFO - 'LOGNAME': 'cltbld', 14:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:09 INFO - 'MOZ_NO_REMOTE': '1', 14:06:09 INFO - 'NO_EM_RESTART': '1', 14:06:09 INFO - 'PAGER': '/bin/cat', 14:06:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:09 INFO - 'PWD': '/builds/slave/test', 14:06:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:09 INFO - 'SHELL': '/bin/bash', 14:06:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:09 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:09 INFO - 'USER': 'cltbld', 14:06:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:09 INFO - 'XPC_FLAGS': '0x0', 14:06:09 INFO - 'XPC_SERVICE_NAME': '0', 14:06:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:09 INFO - Downloading/unpacking psutil>=3.1.1 14:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:13 INFO - Installing collected packages: psutil 14:06:13 INFO - Running setup.py install for psutil 14:06:13 INFO - building 'psutil._psutil_osx' extension 14:06:13 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 14:06:13 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 14:06:13 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 14:06:13 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 14:06:13 INFO - building 'psutil._psutil_posix' extension 14:06:13 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 14:06:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:06:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:06:14 INFO - ^ 14:06:14 INFO - 1 warning generated. 14:06:14 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 14:06:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:14 INFO - Successfully installed psutil 14:06:14 INFO - Cleaning up... 14:06:14 INFO - Return code: 0 14:06:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:06:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:14 INFO - 'HOME': '/Users/cltbld', 14:06:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:14 INFO - 'LOGNAME': 'cltbld', 14:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:14 INFO - 'MOZ_NO_REMOTE': '1', 14:06:14 INFO - 'NO_EM_RESTART': '1', 14:06:14 INFO - 'PAGER': '/bin/cat', 14:06:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:14 INFO - 'PWD': '/builds/slave/test', 14:06:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:14 INFO - 'SHELL': '/bin/bash', 14:06:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:14 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:14 INFO - 'USER': 'cltbld', 14:06:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:14 INFO - 'XPC_FLAGS': '0x0', 14:06:14 INFO - 'XPC_SERVICE_NAME': '0', 14:06:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:06:14 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 14:06:14 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 14:06:14 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 14:06:14 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 14:06:14 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 14:06:14 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 14:06:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:06:17 INFO - Installing collected packages: mozsystemmonitor 14:06:17 INFO - Running setup.py install for mozsystemmonitor 14:06:17 INFO - Successfully installed mozsystemmonitor 14:06:17 INFO - Cleaning up... 14:06:17 INFO - Return code: 0 14:06:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:06:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:17 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:06:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:17 INFO - 'HOME': '/Users/cltbld', 14:06:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:17 INFO - 'LOGNAME': 'cltbld', 14:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:17 INFO - 'MOZ_NO_REMOTE': '1', 14:06:17 INFO - 'NO_EM_RESTART': '1', 14:06:17 INFO - 'PAGER': '/bin/cat', 14:06:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:17 INFO - 'PWD': '/builds/slave/test', 14:06:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:17 INFO - 'SHELL': '/bin/bash', 14:06:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:17 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:17 INFO - 'USER': 'cltbld', 14:06:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:17 INFO - 'XPC_FLAGS': '0x0', 14:06:17 INFO - 'XPC_SERVICE_NAME': '0', 14:06:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:17 INFO - Downloading/unpacking jsonschema==2.5.1 14:06:17 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 14:06:17 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 14:06:17 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 14:06:17 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 14:06:17 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 14:06:17 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 14:06:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:20 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:20 INFO - warning: no files found matching '*.txt' 14:06:20 INFO - no previously-included directories found matching 'build' 14:06:20 INFO - no previously-included directories found matching 'dist' 14:06:20 INFO - no previously-included directories found matching '.git*' 14:06:20 INFO - Installing collected packages: jsonschema, functools32 14:06:20 INFO - Running setup.py install for functools32 14:06:20 INFO - warning: no files found matching '*.txt' 14:06:20 INFO - no previously-included directories found matching 'build' 14:06:20 INFO - no previously-included directories found matching 'dist' 14:06:20 INFO - no previously-included directories found matching '.git*' 14:06:20 INFO - Successfully installed jsonschema functools32 14:06:20 INFO - Cleaning up... 14:06:21 INFO - Return code: 0 14:06:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:21 INFO - 'HOME': '/Users/cltbld', 14:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:21 INFO - 'LOGNAME': 'cltbld', 14:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:21 INFO - 'MOZ_NO_REMOTE': '1', 14:06:21 INFO - 'NO_EM_RESTART': '1', 14:06:21 INFO - 'PAGER': '/bin/cat', 14:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:21 INFO - 'PWD': '/builds/slave/test', 14:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:21 INFO - 'SHELL': '/bin/bash', 14:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:21 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:21 INFO - 'USER': 'cltbld', 14:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:21 INFO - 'XPC_FLAGS': '0x0', 14:06:21 INFO - 'XPC_SERVICE_NAME': '0', 14:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:06:21 INFO - Cleaning up... 14:06:21 INFO - Return code: 0 14:06:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:21 INFO - 'HOME': '/Users/cltbld', 14:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:21 INFO - 'LOGNAME': 'cltbld', 14:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:21 INFO - 'MOZ_NO_REMOTE': '1', 14:06:21 INFO - 'NO_EM_RESTART': '1', 14:06:21 INFO - 'PAGER': '/bin/cat', 14:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:21 INFO - 'PWD': '/builds/slave/test', 14:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:21 INFO - 'SHELL': '/bin/bash', 14:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:21 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:21 INFO - 'USER': 'cltbld', 14:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:21 INFO - 'XPC_FLAGS': '0x0', 14:06:21 INFO - 'XPC_SERVICE_NAME': '0', 14:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:21 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:21 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 14:06:21 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 14:06:21 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 14:06:21 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 14:06:21 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 14:06:21 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 14:06:24 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 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 14:06:24 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 14:06:25 INFO - Downloading docopt-0.6.1.tar.gz 14:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:25 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:25 INFO - Running setup.py install for blobuploader 14:06:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:25 INFO - Running setup.py install for requests 14:06:26 INFO - Running setup.py install for docopt 14:06:26 INFO - Successfully installed blobuploader requests docopt 14:06:26 INFO - Cleaning up... 14:06:26 INFO - Return code: 0 14:06:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:26 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:26 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 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:26 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 14:06:26 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 14:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:26 INFO - 'HOME': '/Users/cltbld', 14:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:26 INFO - 'LOGNAME': 'cltbld', 14:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:26 INFO - 'MOZ_NO_REMOTE': '1', 14:06:26 INFO - 'NO_EM_RESTART': '1', 14:06:26 INFO - 'PAGER': '/bin/cat', 14:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:26 INFO - 'PWD': '/builds/slave/test', 14:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:26 INFO - 'SHELL': '/bin/bash', 14:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:26 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:26 INFO - 'USER': 'cltbld', 14:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:26 INFO - 'XPC_FLAGS': '0x0', 14:06:26 INFO - 'XPC_SERVICE_NAME': '0', 14:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-N8itAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-2698Sm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-Z4mNbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:26 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-0Bvg4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-v9kFLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-NKaSPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-4S67oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-r2DM4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-yIcKBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-UxwecH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-PcF98Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-8UBEjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:27 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-T9kega-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:28 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-eZbcht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:28 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-X3AJBW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:28 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-YWiaD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:28 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-AwqGz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:28 INFO - Running setup.py install for manifestparser 14:06:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:28 INFO - Running setup.py install for mozcrash 14:06:28 INFO - Running setup.py install for mozdebug 14:06:28 INFO - Running setup.py install for mozdevice 14:06:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Running setup.py install for mozfile 14:06:29 INFO - Running setup.py install for mozhttpd 14:06:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Running setup.py install for mozinfo 14:06:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Running setup.py install for mozInstall 14:06:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Running setup.py install for mozleak 14:06:29 INFO - Running setup.py install for mozlog 14:06:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:29 INFO - Running setup.py install for moznetwork 14:06:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:30 INFO - Running setup.py install for mozprocess 14:06:30 INFO - Running setup.py install for mozprofile 14:06:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:30 INFO - Running setup.py install for mozrunner 14:06:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:30 INFO - Running setup.py install for mozscreenshot 14:06:30 INFO - Running setup.py install for moztest 14:06:30 INFO - Running setup.py install for mozversion 14:06:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:31 INFO - Cleaning up... 14:06:31 INFO - Return code: 0 14:06:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:31 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:31 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 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:31 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 14:06:31 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 14:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:31 INFO - 'HOME': '/Users/cltbld', 14:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:31 INFO - 'LOGNAME': 'cltbld', 14:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:31 INFO - 'MOZ_NO_REMOTE': '1', 14:06:31 INFO - 'NO_EM_RESTART': '1', 14:06:31 INFO - 'PAGER': '/bin/cat', 14:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:31 INFO - 'PWD': '/builds/slave/test', 14:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:31 INFO - 'SHELL': '/bin/bash', 14:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:31 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:31 INFO - 'USER': 'cltbld', 14:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:31 INFO - 'XPC_FLAGS': '0x0', 14:06:31 INFO - 'XPC_SERVICE_NAME': '0', 14:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-ldxQMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:31 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)) 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-xwliKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-_sXg6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:31 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)) 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dZ2jnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:31 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)) 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-iLuVeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:31 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)) 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-OMTUem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:31 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)) 14:06:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:31 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-2vbelV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:32 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-S6YAPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:32 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-O3Njvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:32 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-7W26go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-hw9arp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:32 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-UFvWf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-OZhtgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:32 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-f_aElB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-rWle0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:32 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)) 14:06:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:32 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-dtCnNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:06:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:33 INFO - Running setup.py (path:/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/pip-qvuChH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:33 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)) 14:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:33 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)) 14:06:33 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)) 14:06:33 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)) 14:06:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06: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 14:06:35 INFO - Downloading blessings-1.6.tar.gz 14:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:35 INFO - Installing collected packages: blessings 14:06:35 INFO - Running setup.py install for blessings 14:06:35 INFO - Successfully installed blessings 14:06:35 INFO - Cleaning up... 14:06:36 INFO - Return code: 0 14:06:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:36 INFO - Reading from file tmpfile_stdout 14:06:36 INFO - Current package versions: 14:06:36 INFO - blessings == 1.6 14:06:36 INFO - blobuploader == 1.2.4 14:06:36 INFO - docopt == 0.6.1 14:06:36 INFO - functools32 == 3.2.3-2 14:06:36 INFO - jsonschema == 2.5.1 14:06:36 INFO - manifestparser == 1.1 14:06:36 INFO - mozInstall == 1.12 14:06:36 INFO - mozcrash == 1.0 14:06:36 INFO - mozdebug == 0.1 14:06:36 INFO - mozdevice == 0.48 14:06:36 INFO - mozfile == 1.2 14:06:36 INFO - mozhttpd == 0.7 14:06:36 INFO - mozinfo == 0.9 14:06:36 INFO - mozleak == 0.1 14:06:36 INFO - mozlog == 3.4 14:06:36 INFO - moznetwork == 0.27 14:06:36 INFO - mozprocess == 0.23 14:06:36 INFO - mozprofile == 0.28 14:06:36 INFO - mozrunner == 6.13 14:06:36 INFO - mozscreenshot == 0.1 14:06:36 INFO - mozsystemmonitor == 0.3 14:06:36 INFO - moztest == 0.8 14:06:36 INFO - mozversion == 1.4 14:06:36 INFO - psutil == 3.1.1 14:06:36 INFO - requests == 1.2.3 14:06:36 INFO - wsgiref == 0.1.2 14:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:37 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 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:37 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 14:06:37 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 14:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:37 INFO - 'HOME': '/Users/cltbld', 14:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:37 INFO - 'LOGNAME': 'cltbld', 14:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:37 INFO - 'MOZ_NO_REMOTE': '1', 14:06:37 INFO - 'NO_EM_RESTART': '1', 14:06:37 INFO - 'PAGER': '/bin/cat', 14:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:37 INFO - 'PWD': '/builds/slave/test', 14:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:37 INFO - 'SHELL': '/bin/bash', 14:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:37 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:37 INFO - 'USER': 'cltbld', 14:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:37 INFO - 'XPC_FLAGS': '0x0', 14:06:37 INFO - 'XPC_SERVICE_NAME': '0', 14:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 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)) 14:06:37 INFO - Cleaning up... 14:06:37 INFO - Return code: 0 14:06:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10856d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1084e3570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb64956ef10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, '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.vga8ByllxD/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.UJu5SOj9xf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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 14:06:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:06:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:06:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:06:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:37 INFO - 'HOME': '/Users/cltbld', 14:06:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:37 INFO - 'LOGNAME': 'cltbld', 14:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:37 INFO - 'MOZ_NO_REMOTE': '1', 14:06:37 INFO - 'NO_EM_RESTART': '1', 14:06:37 INFO - 'PAGER': '/bin/cat', 14:06:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:37 INFO - 'PWD': '/builds/slave/test', 14:06:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:37 INFO - 'SHELL': '/bin/bash', 14:06:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:06:37 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:06:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:37 INFO - 'USER': 'cltbld', 14:06:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:37 INFO - 'XPC_FLAGS': '0x0', 14:06:37 INFO - 'XPC_SERVICE_NAME': '0', 14:06:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:37 INFO - Cleaning up... 14:06:38 INFO - Return code: 0 14:06:38 INFO - Running post-action listener: _resource_record_post_action 14:06:38 INFO - Running post-action listener: _start_resource_monitoring 14:06:38 INFO - Starting resource monitoring. 14:06:38 INFO - [mozharness: 2017-02-16 22:06:38.030938Z] Finished create-virtualenv step (success) 14:06:38 INFO - [mozharness: 2017-02-16 22:06:38.031909Z] Running install step. 14:06:38 INFO - Running pre-action listener: _resource_record_pre_action 14:06:38 INFO - Running main action method: install 14:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:38 INFO - Reading from file tmpfile_stdout 14:06:38 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:38 INFO - Reading from file tmpfile_stdout 14:06:38 INFO - Output received: 14:06:38 INFO - Usage: mozinstall [options] installer 14:06:38 INFO - Options: 14:06:38 INFO - -h, --help show this help message and exit 14:06:38 INFO - -d DEST, --destination=DEST 14:06:38 INFO - Directory to install application into. [default: 14:06:38 INFO - "/builds/slave/test"] 14:06:38 INFO - --app=APP Application being installed. [default: firefox] 14:06:38 INFO - mkdir: /builds/slave/test/build/application 14:06:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 14:07:00 INFO - Reading from file tmpfile_stdout 14:07:00 INFO - Output received: 14:07:00 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 14:07:00 INFO - Running post-action listener: _resource_record_post_action 14:07:00 INFO - [mozharness: 2017-02-16 22:07:00.064540Z] Finished install step (success) 14:07:00 INFO - [mozharness: 2017-02-16 22:07:00.064669Z] Running run-tests step. 14:07:00 INFO - Running pre-action listener: _resource_record_pre_action 14:07:00 INFO - Running main action method: run_tests 14:07:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:07:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:07:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:07:00 INFO - 2017-02-16 14:07:00.079 screenresolution[1622:7407] starting screenresolution argv=screenresolution get 14:07:00 INFO - 2017-02-16 14:07:00.081 screenresolution[1622:7407] Display 0: 1600x1200x32@60 14:07:00 INFO - 2017-02-16 14:07:00.087 screenresolution[1623:7409] starting screenresolution argv=screenresolution list 14:07:00 INFO - Available Modes on Display 0 14:07:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:07:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:07:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:07:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:07:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:07:00 INFO - Intel Iris: 14:07:00 INFO - Chipset Model: Intel Iris 14:07:00 INFO - Type: GPU 14:07:00 INFO - Bus: Built-In 14:07:00 INFO - VRAM (Dynamic, Max): 1536 MB 14:07:00 INFO - Vendor: Intel (0x8086) 14:07:00 INFO - Device ID: 0x0a2e 14:07:00 INFO - Revision ID: 0x0009 14:07:00 INFO - Displays: 14:07:00 INFO - Display: 14:07:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:07:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:07:00 INFO - Display Serial Number: 1600x1200 60 14:07:00 INFO - Main Display: Yes 14:07:00 INFO - Mirror: Off 14:07:00 INFO - Online: Yes 14:07:00 INFO - Rotation: Supported 14:07:00 INFO - Return code: 0 14:07:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:00 INFO - Python 2.7.3 14:07:00 INFO - Return code: 0 14:07:00 INFO - grabbing minidump binary from tooltool 14:07:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:00 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108381d30>, '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 0x1081e7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108379b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:00 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 14:07:00 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 14:07:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:07:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:00 INFO - Return code: 0 14:07:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:07:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:07:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:00 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', 'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 14:07:00 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 https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0192 --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 14:07:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vga8ByllxD/Render', 14:07:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:00 INFO - 'HOME': '/Users/cltbld', 14:07:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:00 INFO - 'LOGNAME': 'cltbld', 14:07:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:07:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:00 INFO - 'MOZ_NO_REMOTE': '1', 14:07:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:00 INFO - 'NO_EM_RESTART': '1', 14:07:00 INFO - 'PAGER': '/bin/cat', 14:07:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:00 INFO - 'PWD': '/builds/slave/test', 14:07:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:00 INFO - 'SHELL': '/bin/bash', 14:07:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UJu5SOj9xf/Listeners', 14:07:00 INFO - 'TMPDIR': '/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/', 14:07:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:00 INFO - 'USER': 'cltbld', 14:07:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:00 INFO - 'XPC_FLAGS': '0x0', 14:07:00 INFO - 'XPC_SERVICE_NAME': '0', 14:07:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:00 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', 'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0192', '--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 14:07:00 INFO - mozversion application_buildid: 20170216105119 14:07:00 INFO - mozversion application_changeset: 820bc5bd3120853d611af1056f4a2b35528bb927 14:07:00 INFO - mozversion application_display_name: Firefox 14:07:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:00 INFO - mozversion application_name: Firefox 14:07:00 INFO - mozversion application_remotingname: firefox 14:07:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:07:00 INFO - mozversion application_vendor: Mozilla 14:07:00 INFO - mozversion application_version: 52.0 14:07:00 INFO - mozversion platform_buildid: 20170216105119 14:07:00 INFO - mozversion platform_changeset: 820bc5bd3120853d611af1056f4a2b35528bb927 14:07:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:07:00 INFO - mozversion platform_version: 52.0 14:07:00 INFO - using testdate: 1487282820 14:07:00 INFO - actual date: 1487282820 14:07:00 INFO - starting webserver on 'localhost:49249' 14:07:00 INFO - SUITE-START | Running 2 tests 14:07:00 INFO - TEST-START | dromaeo_css 14:07:00 INFO - operating with platform_type : mac_ 14:07:00 INFO - Initialising browser for dromaeo_css test... 14:07:00 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp6dMEoo/profile http://localhost:49249/getInfo.html) 14:07:03 INFO - PROCESS | 1633 | 2017-02-16 14:07:03.756 plugin-container[1637:7594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d3b, name = 'com.apple.tsm.portname' 14:07:03 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:07:03 INFO - PROCESS | 1633 | 2017-02-16 14:07:03.756 plugin-container[1637:7594] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f1b, name = 'com.apple.CFPasteboardClient' 14:07:03 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:07:03 INFO - PROCESS | 1633 | 2017-02-16 14:07:03.756 plugin-container[1637:7594] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:07:03 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 14:07:03 INFO - PROCESS | 1633 | colorDepth:24 14:07:03 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 14:07:03 INFO - PROCESS | 1633 | __metrics 14:07:03 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:07:04 INFO - TEST-INFO | 1633: exit 0 14:07:04 INFO - Browser initialized. 14:07:04 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:04 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmp6dMEoo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:06 INFO - PROCESS | 1638 | 2017-02-16 14:07:06.977 plugin-container[1639:7726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x843f, name = 'com.apple.tsm.portname' 14:07:06 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:07:06 INFO - PROCESS | 1638 | 2017-02-16 14:07:06.978 plugin-container[1639:7726] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 14:07:06 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:07:06 INFO - PROCESS | 1638 | 2017-02-16 14:07:06.978 plugin-container[1639:7726] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:07:16 INFO - PROCESS | 1638 | RSS: Main: 177811456 14:07:16 INFO - PROCESS | 1638 | 14:10:18 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 14:10:20 INFO - PROCESS | 1638 | RSS: Main: 183087104 14:10:20 INFO - PROCESS | 1638 | 14:13:22 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 14:13:23 INFO - PROCESS | 1638 | RSS: Main: 194301952 14:13:23 INFO - PROCESS | 1638 | 14:16:25 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 14:16:25 INFO - PROCESS | 1638 | RSS: Main: 195547136 14:16:25 INFO - PROCESS | 1638 | 14:19:27 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 14:19:28 INFO - PROCESS | 1638 | RSS: Main: 199610368 14:19:28 INFO - PROCESS | 1638 | 14:22:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 14:22:31 INFO - PROCESS | 1638 | RSS: Main: 205115392 14:22:31 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 14:25:34 INFO - PROCESS | 1638 | RSS: Main: 205287424 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | __start_tp_report 14:25:34 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 14:25:34 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 14:25:34 INFO - PROCESS | 1638 | |i|pagename|runs| 14:25:34 INFO - PROCESS | 1638 | |0;dojo.html;3162.6679198684137;3570.785752854829;3616.945745813813;3618.203995121074;3619.950214437813;4808.927866082012;5884.705764711764;5982.850428739278;5999.610025348355;6000.489958353545;5915.763369465227;5985.281766188053;5995.13070604762;6009.068594367869;6010;4083.9994201420695;5342.946570534294;5384.892302153955;5424.864378390552;5440.3743569489425;4579.290210017436;5268;5438.456154384549;5456.372517160537;5459.317585301837;5310.15037593985;5325.068113080215;5420.295361602986;5430.5384042356445;5439.102548079562;4340.978295108536;4899.191633380488;5436.619436639437;5457.918131228034;5502.614816962814;5301.840944771663;5415.10650742627;5422.593305502063;5424.105022671254;5457.154141108134;5782.653040817564;5989.610675306091;5998.910016349758;6071.726772295257;6096.390360963868;6174.660393678346;6186.474149697281;6188.87622247557;6227;6240.063990401431;5264.6051546134195;6297.370262973712;6319.715612797435;6369.585976911486;6373.075903993941;6136.815895523141;6143.539234557336;6157.230346206769;6159.84600384994;6172.87654246917;6240;6299.401556852092;6385.776497822554;6414.1340918976275;6455.903161452582;6292.779752708633;6296.5592408530965;6300.779472718433;6312.5265605078885;6319.652419116901;6331.145295385156;6355.777547785898;6356.809295721136;6369.617822930639;6448.193975753031;6184.845378865564;6196.47329976948;6226.159468471698;6230.813075607739;6261.311255761862;6240.937590624127;6256.436920677161;6269.144476147137;6280.403361680633;6284.994400895835;3879.476270703475;5138.075146473596;5160.767765450564;5170.302009228782;5174.275601415729;4497.100579884036;4497.257952437811;4525.434320709911;4530.093981203772;4624.722516649012;6050.697465126814;6051.606645568024;6104.877902441926;6112.847178820565;6116.457510225689;6349.047642853517;6360.681965901686;6363.172787537683;6395.776147834804;6397.840053998687;5933.991221492357;5998.580099393001;5999.550033747487;6037.879242415215;6042.214512113485;5625.184348269478;5657.12314591239;5660.349059858169;5669.603127781098;5677.148427735872;6514.413702766774;6524.608523488606;6531.085648009187;6544.476441884638;6549.901751473827;6219.378062193744;6220.595661282002;6263.843403914939;6275;6315.179026726496;6516.73933042673;6531.510136739668;6541.051547525487;6543.967280163569;6581.80254592363;6296.181496405621;6306;6311.368863113836;6312.779052733133;6316.242050953915;6198.690065496798;6265.342139075331;6283.654399008098;6318.968405157945;6365.267994180544;6129.509639228761;6175.135481032748;6270.561060725888;6280.623162610258;6301.4643755279485;6231.345708700703;6245.406686364788;6252.280987686474;6269.874602507833;6282.811515654537;5066.203818497396;6099.024156134997;6172.598781079216;6230.06549017651;6279.026750853625;6108.09924418988;6181.196444462191;6193.783217587363;6195.101710251898;6268;6127.387261273837;6206.906896396648;6213.875722485615;6220.284667263141;6246.063090536456 14:25:34 INFO - PROCESS | 1638 | |1;ext.html;481.28288849614063;494.93318402015717;526.1949217696924;540.3758658749147;562.052940794761;38096;42528.78735606325;42612.14775704488;42615.14769704608;42617.7869110654;40719.79640101796;41361.96595085124;41393.96515087124;41433.964150896165;41443.756687299356;9365.297602679791;9547.809043819154;9555.996620354867;9567.186789122932;9599.95200023999;8226;9462.479563623998;9486.478243696594;9524.238060955107;9596.040395960417;8154.8776768348525;9434.905650943472;9509.286803489766;9551.140397364235;9591.328606997513;9404.576794044284;9442.575084121198;9496.572654230577;9562.28282878787;9598.328117031811;8208.46644968075;9425.151736343762;9440.480773557452;9470.14768670823;9562.952185239099;39973;40076.398854017214;40348.79825600883;40364.59635403638;40442.39336409956;3307.7188438982716;3494.9126271843406;3534.452159915217;3562.340966921128;3984.342583473723;23980.400489987715;29196.270093247625;29686.406271874443;31409;31487.527687084712;2905.825650460979;3154.794938329001;3202.455582550972;3241.918952026195;3370.561826962504;495838;497502;497626;500476;500691;57012;57151;57197.71401142968;57505.71247143738;57679.423205768246;59389.70305148533;59540;59550;59659.403405965386;59706;16381.67236655284;16582;16608.335666573443;16614.91692541554;16743.83256167447;12860.485580576858;12919.96640268795;12959.352032398343;12963.222206667442;12964.935175324252;13678.905687544973;14703;15254.923725381303;15416.460423885335;15571.688566228839;5243.947560524422;6060.969695151496;6160.691965401712;6179.783707570214;6192.752289908353;907.7866701325183;925.121134921827;994.7463396833762;1019.4189312092185;1111.9499622517005;29158.854205728836;29160.270993224916;29536.852315738284;29855;29891;898.9572096368181;1045.8901815309434;1069.4225118436113;1101.6419663609358;1139.6125317392127;13903.721925561635;14268.571942841523;15264.3894244229;15266.931314807856;15439.552275766386;627361;631941;632436;632818;634754;56621;56813.43186568082;57202.427975720544;57228.56928576736;57341.42658573361;1343.4156142078227;1382.861713828609;1403.698204885934;1414.886809055273;1418.14202407544;29031.838726450704;29859.850700746356;29981.55027674543;30093.247668808453;30352.78588856421;47750.52249477461;48399.75800120977;48797.512024879295;48879.75560122177;48926;517374;521788;524656;525379;526335;25311.74688253094;25390.111346102796;25427.237182884543;25666.8716656423;25674.486510270064;43590.56409435865;44093.677189684364;44278;44372.77813610911;44793.77603111963;35482.11294717653;36218.275634486636;36435.635643643225;37219.62780372162;37623.81188094042;36226.8188659055;36413.01110074021;37139;37231;37529.6247037537;28560.285992849513;32065.6793432072;36691.81654091713;36776.0805979842;37188.07029824276;31059.689403106582;33056.66943330632;33089.50365744564;33136.1715957103;33217.83391083029;21679.34961951144;23637.963092548616;25181.118660846783;25361;25536.48927021412 14:25:34 INFO - PROCESS | 1638 | |2;jquery.html;342.912557297889;351.811780697327;385.91509867829086;404.23599397139395;419.1428528658892;18838.43484695458;20469.590608187864;21147.47131321718;21306.57386852264;21359.252426165087;20257.49356266094;20545.075471603777;20598.691019634716;20768.792312076876;20943.05756240969;5789.594728369016;5977.701114944235;7370.74202402916;7710.383169346467;7785.610719464033;4607.417523537998;7327.706891724325;7550.244975502434;7680.884786728176;7716.035495563055;7686.769396918102;7759.767206983771;7764.2235776422185;7772;7773.300402963732;7359.190489046201;7630.329384715361;7638.312551870303;7669.348105411047;7675.884861727079;7155.177154627232;7397.334239918379;7419.888701669479;7491.175970643225;7494.775156745306;28210;28322.858385708147;28660.426791464262;28788;29210.831566737306;2354.6350315701093;2472.9629055564183;2501.699796024489;2528.077251803097;2813.353761633454;14893.70212595742;15717;16198.190090495427;16788.748168777478;17029.91485042567;2023.4132101690493;2096.4863608416035;2116.1323857218467;2124.150339864051;2136.59404713104;134027;134063;134690.6530934688;139328;139648.30175849056;17385.391511297043;21736.565268694536;21947.780522194895;22240.888795556242;22273.77726222717;35940.64059359425;36093.27813443769;36418.45372319417;36634;36688.44967325492;10855.40295283767;10937.671869843918;10949.4525273736;11172.664820055412;11304.15218858589;8987.865182022275;8996;9034.412763170505;9042.502662353501;9166.312526560534;7495.437842161859;7998.520088794691;9892;9996.850047249298;10009.698739164007;1629.9266533006044;1721.9397321093952;1726.2318268370705;3862.362710152793;3971.225611005826;871.6687658689784;877.9429337093069;926.6386109417333;929.9116583924516;979.1628157924872;17846.28614855391;18701.784384014994;20882.164713411596;21374.14503419877;21554.13783448676;861.1517655109712;954.61815273891;957.4303289542711;960.6589660670501;1018.8828284747201;10755;11120.110391168688;11190.38452885083;11319.434028298552;11395.487203075882;557890;561362;590804;597200;627863;130734;131511;133216.3339183298;135425;137421;952.1097773581723;972.9221662267001;1017.6234793126442;1042.8279333909973;1046.4349251404308;19092.71360929615;19631.93864644192;19737.605247894673;19761.01194940276;19981.000949952155;47639.52360476351;55508;56735.14897276462;57182;58960;75569;77597;77687.44625107579;77760;77869.61065194638;6896.241413444417;7292.927070729224;7308.8538229234055;7577;7798.220177982156;10758.354498730101;10820.404877731486;12269.263844169378;12303.44634491432;12903.032272579781;10482.947585262025;10546.525406356886;10637.468126593485;10888.658938328297;10994.230403871652;10510;10790.67627971162;10848.294860834021;10915.454227288445;11006.229563930448;5762.250907382014;6450.903236451363;10697.502349670896;10836.837447438136;10878.51046702916;7320.743773967885;7331.303526165006;7475.028246327943;7496.325330720261;7635.580043097683;8961.507117108622;9033;10632.734181645212;10799.244052916534;10833.837492437462 14:25:34 INFO - PROCESS | 1638 | |3;mootools.html;1479.1273148842183;1515.8559936806002;1689.6958547461452;1793.1572161084302;1839.5033340997923;7568.470207085506;7793.53238805672;8073.555954422504;8499.490030598161;8519.616617252223;8147.674093036271;8408.159184081589;8421.410501264914;8422.494650320985;8444.577771111435;2032.9835082458771;2334.241371554243;2371.620540713486;2389.199618127929;2394.3415560720855;2344.9179278725246;2373.41851246444;2382.5711371953043;2407.2537513370826;2407.5064611754638;2000.4998750312423;2315.8957846896847;2331.778481044307;2353.564590550745;2378.4886249456363;1934.3809980806077;2319.9188028419094;2328.7205535335697;2343.6250199968094;2346.6245400735884;2375.5367703297866;2383.630537266709;2389.7371289158355;2397.916072937439;2416.395901024744;7235.602041887694;7818.45270831042;8249.546274954875;8442.15578442157;8463.111373305837;4760.500147484534;5188.9740551297;5200.8179713710215;5201.817936372209;5223.921641175385;3227.144806626246;3354.194993201638;3482.460218666111;3539.592946811098;3570.4465807799834;942.9811403771886;1036.4921188617523;1062.2086545523634;1113.560143743225;1141.5034460009922;10789.946050269777;10811.675649730521;10874.945625271903;10914.963078507608;10916.890831091747;4484.910301793946;4591.737272250158;4645.558671926162;4674.298855171752;4718.820294926269;9293.953530232306;9321.533923303808;9353.719388418358;9355.859662105075;9395.248380129573;5181.4041385240425;5192.506711862367;5203.063448579292;5205.375354957429;5212.087884620177;4286.549912259168;4328.523862375137;4760.666753327234;4789.760511974388;4803.759812009385;3824.8661296854475;3880.476135721698;3955.149642826806;3962.663173630216;3974.0263635408933;1134.5178299222798;1302.5701518499063;1303.5633062923837;1309.508934149694;1320.0825426328802;806.7781360126012;879.3712495565701;884.4869975414244;893.7542175901549;918.8300164469595;4469.575390337913;5566.860828479239;5580.497755202051;5767.423257674199;5870.5010074144175;934.5981228071994;972.6060945317158;987.2990176974429;991.4546999150439;1014.9289549731448;3840;3881.204353107606;3882.2817778710464;3915.686745060388;3996.680265578747;9856.31005829585;10169.898301017043;10175.694729158136;10176.491175441346;10185.9490702546;9323.580438880266;9550.044995500533;9834.60661573529;10013;10023.799524009624;6719.865602687919;7457.216992215847;7675.462717609826;7739.883901741478;7920.128785833554;4812.374391329105;5808.7095645218415;5856.795012174553;5964.224650795542;6123.9693801532485;7286.6720997556295;8161.183881611792;8997.82004359896;9421.340506164503;9449.763755906157;8260.380471464545;8890.888638920134;8959;9521.809563808823;9577.760555986157;6522.869542609216;6712.798616041527;6912.239653637996;7021.227664956748;7200.207977122617;7676.232376762502;7814.492058016211;7858.567778771993;7865.252800983897;7880.975473188449;7038.436925046087;7221.31397517235;7239.239879812544;7248.492605517563;7309.597972111372;7013.333733295329;7057.435405167472;7076.469264805057;7181.676824543013;7187.892181617175;6714.563553369211;6721.697523611547;6750.763723269662;6778.932210678027;6800.115984922127;4791.880202994953;4794.688345257547;4817.542333478314;4837.443693975097;4845.8061677533915;4807.399075115611;4872.658913875995;4884.804607815648;4959.20652695567;4978.153713868724 14:25:34 INFO - PROCESS | 1638 | |4;prototype.html;248.85566371504518;314.66645355922725;323.40977715668896;324.14264271003185;325.890826573098;4644.3730096436975;5232.8691782705455;5337.412884582693;5518.944810551893;5525.944740552593;4686.953130468694;5247.790088396469;5459.754311056002;5470.17947307904;5479.123340265548;3675.7210529471763;4140.689448291375;4244.702870799038;4249.893752656178;4252.447181866369;3718.40505519117;3914.9608503915024;4176.7911604419805;4267.167902259061;4285.914281714364;3442.397580423416;4126.277901367249;4138.689598280126;4156.625903668669;4170.791460426982;4125.339945608704;4135.932033982994;4148.315527937887;4148.502179738451;4154.667626589866;3435.5018522314376;3548.201654627714;3575.76757510761;3598.514200582914;3600.9557228403733;4627.537246275379;4845.345878306419;5326.201069839516;5348.438413966555;5356.009138309425;4170.186813571355;4183.435236243099;4190.455240818705;4311.545894443531;4384.013596940695;5376.301080859464;5770.980156945077;5777.768889244468;5795.189992306376;5807.535397168216;3927.410888366739;3953.881383558498;3955.584663610337;3966.3852102924093;3976.7216294859372;6059.6364218147055;6106.3896757947905;6122.540809439265;6137.9079313810325;6145.969270153665;3891.9221615568094;3951.3677811550015;3984.6613037891525;4028.2950483665827;4032.2338755636333;4051.5745846686264;4102.097538541516;4104.42538044674;4109.760180701524;4143.854965076268;4064.8577299794365;4744.715317080986;4809.893724443327;4829.444613869379;4874.512548745168;5156.355455568054;5631.211630371751;5804.126957156234;5887.587868849139;5907.7046147692445;1147;1300.90243231758;1335.9666008349868;1349.0354396606474;1349.1230700044853;873.2926329672986;882.8984666763276;900.8558630619069;901.369041670833;908.5775114571755;4055.904905675451;4440.755758433317;4972.925406118911;5166.062726477571;5199.532042116228;5147.124988751922;5225.6603320784025;5541.5289700375115;5704.572157088235;5828.562857785683;4529.68292219548;4854.129706288234;5007.9499205008215;5219.947800522022;5263.26314315996;2573.189445324754;2744.643196384497;2789.7499413183414;2911.9417611648073;2986.7013298670395;4928.950710492921;5296.523312901857;5356.517913387814;5392.923724366147;6007.759689612367;4626.097910907408;5329.200619907045;5702.6354749787;5708.828735137952;5791.189233507313;5144.897102058013;5453.781848726086;5570.805021824217;5823.088455772114;5852.941470585325;5040.470750571138;5076.42630784458;5387.784488620411;5452.182172673972;5789.421057894177;4703.45910220329;5236;5510.311211098613;5608.495235428831;5657.660540367591;5582.720863956704;5839.408763610434;5907.881842363215;5932.7033648318275;5978.312494063064;3552.9644703553668;3727.807101727421;3787.0532366908274;3841.5966323535627;3879.3792993122092;5200.63595548308;5609.831705048855;5707.032343181605;5780.364159942319;5989.970050149721;5848.970755146197;5887.764489420375;5918.674472904032;5937.2578427696535;5951.761929522944;4956.55391014796;5920.365437380325;5923.933691935493;5948.196993405835;5994.430529099728;4710.623150148049;5017.422996355466;5712.285964254468;5734.569907256889;5747.942520574908;4930.0419748150825;5000;5816.621919575214;5972.820815375546;5987.75459202799;4859.809346710079;5380.892382152413;5814.900495150993;5832.358440571449;5907.877503274364 14:25:34 INFO - PROCESS | 1638 | |5;yui.html;612.8253447767381;657.3919124809549;720.747738291598;741.5698894641108;767.5241350362775;14349.497767578137;14876.47932322369;15199.77200341993;15282.923585382085;15348.386064557419;13814.240216788072;13888.305584720749;13977.371018304175;13978.720425591482;14039.578812635636;861.5218553702708;875.9562021898911;877.5875338590852;878.1920633017639;878.9472631642122;826.499967519651;861.6682577207789;864.235151890575;867.8524650809346;870.5342641686699;771.3212373111654;880.0847118996236;882.1399135842566;900.1898291537603;900.4777229207077;891.4161224397998;892.085612247445;895.0914821456195;896.0054339682947;896.5875697179305;649.7628365646552;655.4952686431421;667.3360006793272;667.8263651450609;667.8397184675691;13917.652058698512;14107.717845643132;14283.714325713427;14290.713835754728;14314.069585477015;13229.12504994011;13390;13528.526501572398;13598.660033499242;14023.649408764863;11306.321620702702;11380.544778208945;11575.0161236295;11623.302601843916;11668.416579171093;3719.1817800083936;3744.700423966076;3943.5464921533817;3970.3845903884944;3980.86066987654;62870;90506.54746726224;92987.53506232493;95772;96338.55492167623;10614.787704245871;10660.680179594625;10689.251752377259;10925.453727313603;11016.283941543934;17598.208080636403;20505.692414613794;20894.37316880496;20977;21112.838793866176;7865.4494185406475;7934.841303173905;8001.319887809485;8108.5945702714625;8126.878096828552;4387.298032314879;4391.429114215195;4403.163398954189;4416;4500.099980004013;3348.6149092854635;3397.9490307645406;3446.5864096308605;3451.326991236735;3466.7746596471147;569.9287589051369;576.5618130220978;635.6885126288086;637.1303171171318;657.8190997475732;562.8874225154904;646.4892734739503;654.3489228217953;659.5727721983149;675.9222689390783;7943.1972517376325;8781.463243932414;9187.127222913812;9222.76943076415;9312.255019598417;622.3682961793783;657.3065415986181;680.1633990192091;685.6126288646899;687.7180356053993;4185.727927684691;4306.457700176785;4382.211201983673;4544.227481328182;4560.749158796231;65904.6819063616;75996.86004709934;115562.84437155689;117154;117450;93869;99756;102025;103440.48279758553;103834;44913.87715307144;60854.4786380344;61015.69492152511;62223;93651.53174234086;8817.878049143925;8849.247813935888;8903.955480222558;8923.41997770143;9057.54712264371;53077.7346113267;58444;58882.822343553744;59080.704596476746;60698.393016069276;81453;82289.58855205686;83354.58322708348;85409.14590854011;87326;11156.776864462827;11297.7740445189;11403.657890263305;11642.41787910618;11679.883201167879;12099.81850272229;12403.689907752378;12663.493460261854;12685.23888566689;12771.93614031924;11161.720956975816;11856.70358241051;11905.226160299553;12047.939760301142;12274.877251227374;11514.194006419806;11886.762264754829;12021.278723276631;12120.878791211975;12195.695107622025;11500.53997840077;11641.941790290994;11733.76532469363;11798.52805887755;12021.819672704742;9621.230301575997;9795.9020409795;9970.351927124713;10038.1467575254;10048.397096174253;9169.961263527686;9202.631894724136;10089.89910100919;10207.438590877277;10256.846147307648 14:25:34 INFO - PROCESS | 1638 | __end_tp_report 14:25:34 INFO - PROCESS | 1638 | __start_cc_report 14:25:34 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,368 14:25:34 INFO - PROCESS | 1638 | __end_cc_report 14:25:34 INFO - PROCESS | 1638 | __startTimestamp1487283934850__endTimestamp 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | ------- Summary: start ------- 14:25:34 INFO - PROCESS | 1638 | Number of tests: 6 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5874.55 Median:6174.66 stddev:682.33 (11.1%) stddev-sans-first:650.42 14:25:34 INFO - PROCESS | 1638 | Values: 3162.7 3570.8 3616.9 3618.2 3620.0 4808.9 5884.7 5982.9 5999.6 6000.5 5915.8 5985.3 5995.1 6009.1 6010.0 4084.0 5342.9 5384.9 5424.9 5440.4 4579.3 5268.0 5438.5 5456.4 5459.3 5310.2 5325.1 5420.3 5430.5 5439.1 4341.0 4899.2 5436.6 5457.9 5502.6 5301.8 5415.1 5422.6 5424.1 5457.2 5782.7 5989.6 5998.9 6071.7 6096.4 6174.7 6186.5 6188.9 6227.0 6240.1 5264.6 6297.4 6319.7 6369.6 6373.1 6136.8 6143.5 6157.2 6159.8 6172.9 6240.0 6299.4 6385.8 6414.1 6455.9 6292.8 6296.6 6300.8 6312.5 6319.7 6331.1 6355.8 6356.8 6369.6 6448.2 6184.8 6196.5 6226.2 6230.8 6261.3 6240.9 6256.4 6269.1 6280.4 6285.0 3879.5 5138.1 5160.8 5170.3 5174.3 4497.1 4497.3 4525.4 4530.1 4624.7 6050.7 6051.6 6104.9 6112.8 6116.5 6349.0 6360.7 6363.2 6395.8 6397.8 5934.0 5998.6 5999.6 6037.9 6042.2 5625.2 5657.1 5660.3 5669.6 5677.1 6514.4 6524.6 6531.1 6544.5 6549.9 6219.4 6220.6 6263.8 6275.0 6315.2 6516.7 6531.5 6541.1 6544.0 6581.8 6296.2 6306.0 6311.4 6312.8 6316.2 6198.7 6265.3 6283.7 6319.0 6365.3 6129.5 6175.1 6270.6 6280.6 6301.5 6231.3 6245.4 6252.3 6269.9 6282.8 5066.2 6099.0 6172.6 6230.1 6279.0 6108.1 6181.2 6193.8 6195.1 6268.0 6127.4 6206.9 6213.9 6220.3 6246.1 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:67910.68 Median:40403.49 stddev:148077.46 (366.5%) stddev-sans-first:148406.31 14:25:34 INFO - PROCESS | 1638 | Values: 481.3 494.9 526.2 540.4 562.1 38096.0 42528.8 42612.1 42615.1 42617.8 40719.8 41362.0 41394.0 41434.0 41443.8 9365.3 9547.8 9556.0 9567.2 9600.0 8226.0 9462.5 9486.5 9524.2 9596.0 8154.9 9434.9 9509.3 9551.1 9591.3 9404.6 9442.6 9496.6 9562.3 9598.3 8208.5 9425.2 9440.5 9470.1 9563.0 39973.0 40076.4 40348.8 40364.6 40442.4 3307.7 3494.9 3534.5 3562.3 3984.3 23980.4 29196.3 29686.4 31409.0 31487.5 2905.8 3154.8 3202.5 3241.9 3370.6 495838.0 497502.0 497626.0 500476.0 500691.0 57012.0 57151.0 57197.7 57505.7 57679.4 59389.7 59540.0 59550.0 59659.4 59706.0 16381.7 16582.0 16608.3 16614.9 16743.8 12860.5 12920.0 12959.4 12963.2 12964.9 13678.9 14703.0 15254.9 15416.5 15571.7 5243.9 6061.0 6160.7 6179.8 6192.8 907.8 925.1 994.7 1019.4 1111.9 29158.9 29160.3 29536.9 29855.0 29891.0 899.0 1045.9 1069.4 1101.6 1139.6 13903.7 14268.6 15264.4 15266.9 15439.6 627361.0 631941.0 632436.0 632818.0 634754.0 56621.0 56813.4 57202.4 57228.6 57341.4 1343.4 1382.9 1403.7 1414.9 1418.1 29031.8 29859.9 29981.6 30093.2 30352.8 47750.5 48399.8 48797.5 48879.8 48926.0 517374.0 521788.0 524656.0 525379.0 526335.0 25311.7 25390.1 25427.2 25666.9 25674.5 43590.6 44093.7 44278.0 44372.8 44793.8 35482.1 36218.3 36435.6 37219.6 37623.8 36226.8 36413.0 37139.0 37231.0 37529.6 28560.3 32065.7 36691.8 36776.1 37188.1 31059.7 33056.7 33089.5 33136.2 33217.8 21679.3 23638.0 25181.1 25361.0 25536.5 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:36869.65 Median:28491.64 stddev:98550.24 (345.9%) stddev-sans-first:98788.54 14:25:34 INFO - PROCESS | 1638 | Values: 342.9 351.8 385.9 404.2 419.1 18838.4 20469.6 21147.5 21306.6 21359.3 20257.5 20545.1 20598.7 20768.8 20943.1 5789.6 5977.7 7370.7 7710.4 7785.6 4607.4 7327.7 7550.2 7680.9 7716.0 7686.8 7759.8 7764.2 7772.0 7773.3 7359.2 7630.3 7638.3 7669.3 7675.9 7155.2 7397.3 7419.9 7491.2 7494.8 28210.0 28322.9 28660.4 28788.0 29210.8 2354.6 2473.0 2501.7 2528.1 2813.4 14893.7 15717.0 16198.2 16788.7 17029.9 2023.4 2096.5 2116.1 2124.2 2136.6 134027.0 134063.0 134690.7 139328.0 139648.3 17385.4 21736.6 21947.8 22240.9 22273.8 35940.6 36093.3 36418.5 36634.0 36688.4 10855.4 10937.7 10949.5 11172.7 11304.2 8987.9 8996.0 9034.4 9042.5 9166.3 7495.4 7998.5 9892.0 9996.9 10009.7 1629.9 1721.9 1726.2 3862.4 3971.2 871.7 877.9 926.6 929.9 979.2 17846.3 18701.8 20882.2 21374.1 21554.1 861.2 954.6 957.4 960.7 1018.9 10755.0 11120.1 11190.4 11319.4 11395.5 557890.0 561362.0 590804.0 597200.0 627863.0 130734.0 131511.0 133216.3 135425.0 137421.0 952.1 972.9 1017.6 1042.8 1046.4 19092.7 19631.9 19737.6 19761.0 19981.0 47639.5 55508.0 56735.1 57182.0 58960.0 75569.0 77597.0 77687.4 77760.0 77869.6 6896.2 7292.9 7308.9 7577.0 7798.2 10758.4 10820.4 12269.3 12303.4 12903.0 10482.9 10546.5 10637.5 10888.7 10994.2 10510.0 10790.7 10848.3 10915.5 11006.2 5762.3 6450.9 10697.5 10836.8 10878.5 7320.7 7331.3 7475.0 7496.3 7635.6 8961.5 9033.0 10632.7 10799.2 10833.8 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5407.59 Median:5190.74 stddev:2913.08 (56.1%) stddev-sans-first:2906.29 14:25:34 INFO - PROCESS | 1638 | Values: 1479.1 1515.9 1689.7 1793.2 1839.5 7568.5 7793.5 8073.6 8499.5 8519.6 8147.7 8408.2 8421.4 8422.5 8444.6 2033.0 2334.2 2371.6 2389.2 2394.3 2344.9 2373.4 2382.6 2407.3 2407.5 2000.5 2315.9 2331.8 2353.6 2378.5 1934.4 2319.9 2328.7 2343.6 2346.6 2375.5 2383.6 2389.7 2397.9 2416.4 7235.6 7818.5 8249.5 8442.2 8463.1 4760.5 5189.0 5200.8 5201.8 5223.9 3227.1 3354.2 3482.5 3539.6 3570.4 943.0 1036.5 1062.2 1113.6 1141.5 10789.9 10811.7 10874.9 10915.0 10916.9 4484.9 4591.7 4645.6 4674.3 4718.8 9294.0 9321.5 9353.7 9355.9 9395.2 5181.4 5192.5 5203.1 5205.4 5212.1 4286.5 4328.5 4760.7 4789.8 4803.8 3824.9 3880.5 3955.1 3962.7 3974.0 1134.5 1302.6 1303.6 1309.5 1320.1 806.8 879.4 884.5 893.8 918.8 4469.6 5566.9 5580.5 5767.4 5870.5 934.6 972.6 987.3 991.5 1014.9 3840.0 3881.2 3882.3 3915.7 3996.7 9856.3 10169.9 10175.7 10176.5 10185.9 9323.6 9550.0 9834.6 10013.0 10023.8 6719.9 7457.2 7675.5 7739.9 7920.1 4812.4 5808.7 5856.8 5964.2 6124.0 7286.7 8161.2 8997.8 9421.3 9449.8 8260.4 8890.9 8959.0 9521.8 9577.8 6522.9 6712.8 6912.2 7021.2 7200.2 7676.2 7814.5 7858.6 7865.3 7881.0 7038.4 7221.3 7239.2 7248.5 7309.6 7013.3 7057.4 7076.5 7181.7 7187.9 6714.6 6721.7 6750.8 6778.9 6800.1 4791.9 4794.7 4817.5 4837.4 4845.8 4807.4 4872.7 4884.8 4959.2 4978.2 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4582.78 Median:5110.66 stddev:1409.19 (27.6%) stddev-sans-first:1375.08 14:25:34 INFO - PROCESS | 1638 | Values: 248.9 314.7 323.4 324.1 325.9 4644.4 5232.9 5337.4 5518.9 5525.9 4687.0 5247.8 5459.8 5470.2 5479.1 3675.7 4140.7 4244.7 4249.9 4252.4 3718.4 3915.0 4176.8 4267.2 4285.9 3442.4 4126.3 4138.7 4156.6 4170.8 4125.3 4135.9 4148.3 4148.5 4154.7 3435.5 3548.2 3575.8 3598.5 3601.0 4627.5 4845.3 5326.2 5348.4 5356.0 4170.2 4183.4 4190.5 4311.5 4384.0 5376.3 5771.0 5777.8 5795.2 5807.5 3927.4 3953.9 3955.6 3966.4 3976.7 6059.6 6106.4 6122.5 6137.9 6146.0 3891.9 3951.4 3984.7 4028.3 4032.2 4051.6 4102.1 4104.4 4109.8 4143.9 4064.9 4744.7 4809.9 4829.4 4874.5 5156.4 5631.2 5804.1 5887.6 5907.7 1147.0 1300.9 1336.0 1349.0 1349.1 873.3 882.9 900.9 901.4 908.6 4055.9 4440.8 4972.9 5166.1 5199.5 5147.1 5225.7 5541.5 5704.6 5828.6 4529.7 4854.1 5007.9 5219.9 5263.3 2573.2 2744.6 2789.7 2911.9 2986.7 4929.0 5296.5 5356.5 5392.9 6007.8 4626.1 5329.2 5702.6 5708.8 5791.2 5144.9 5453.8 5570.8 5823.1 5852.9 5040.5 5076.4 5387.8 5452.2 5789.4 4703.5 5236.0 5510.3 5608.5 5657.7 5582.7 5839.4 5907.9 5932.7 5978.3 3553.0 3727.8 3787.1 3841.6 3879.4 5200.6 5609.8 5707.0 5780.4 5990.0 5849.0 5887.8 5918.7 5937.3 5951.8 4956.6 5920.4 5923.9 5948.2 5994.4 4710.6 5017.4 5712.3 5734.6 5747.9 4930.0 5000.0 5816.6 5972.8 5987.8 4859.8 5380.9 5814.9 5832.4 5907.9 14:25:34 INFO - PROCESS | 1638 | 14:25:34 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20008.26 Median:4552.49 stddev:29556.24 (649.2%) stddev-sans-first:29603.28 14:25:34 INFO - PROCESS | 1638 | Values: 612.8 657.4 720.7 741.6 767.5 14349.5 14876.5 15199.8 15282.9 15348.4 13814.2 13888.3 13977.4 13978.7 14039.6 861.5 876.0 877.6 878.2 878.9 826.5 861.7 864.2 867.9 870.5 771.3 880.1 882.1 900.2 900.5 891.4 892.1 895.1 896.0 896.6 649.8 655.5 667.3 667.8 667.8 13917.7 14107.7 14283.7 14290.7 14314.1 13229.1 13390.0 13528.5 13598.7 14023.6 11306.3 11380.5 11575.0 11623.3 11668.4 3719.2 3744.7 3943.5 3970.4 3980.9 62870.0 90506.5 92987.5 95772.0 96338.6 10614.8 10660.7 10689.3 10925.5 11016.3 17598.2 20505.7 20894.4 20977.0 21112.8 7865.4 7934.8 8001.3 8108.6 8126.9 4387.3 4391.4 4403.2 4416.0 4500.1 3348.6 3397.9 3446.6 3451.3 3466.8 569.9 576.6 635.7 637.1 657.8 562.9 646.5 654.3 659.6 675.9 7943.2 8781.5 9187.1 9222.8 9312.3 622.4 657.3 680.2 685.6 687.7 4185.7 4306.5 4382.2 4544.2 4560.7 65904.7 75996.9 115562.8 117154.0 117450.0 93869.0 99756.0 102025.0 103440.5 103834.0 44913.9 60854.5 61015.7 62223.0 93651.5 8817.9 8849.2 8904.0 8923.4 9057.5 53077.7 58444.0 58882.8 59080.7 60698.4 81453.0 82289.6 83354.6 85409.1 87326.0 11156.8 11297.8 11403.7 11642.4 11679.9 12099.8 12403.7 12663.5 12685.2 12771.9 11161.7 11856.7 11905.2 12047.9 12274.9 11514.2 11886.8 12021.3 12120.9 12195.7 11500.5 11641.9 11733.8 11798.5 12021.8 9621.2 9795.9 9970.4 10038.1 10048.4 9170.0 9202.6 10089.9 10207.4 10256.8 14:25:34 INFO - PROCESS | 1638 | -------- Summary: end -------- 14:25:34 INFO - PROCESS | 1638 | 14:25:35 INFO - TEST-INFO | 1638: exit 0 14:25:35 INFO - TEST-OK | dromaeo_css | took 1114784ms 14:25:35 INFO - TEST-START | kraken 14:25:35 INFO - operating with platform_type : mac_ 14:25:35 INFO - Initialising browser for kraken test... 14:25:35 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpWBuiZy/profile http://localhost:49249/getInfo.html) 14:25:38 INFO - PROCESS | 1649 | 2017-02-16 14:25:38.214 plugin-container[1651:9994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434f, name = 'com.apple.tsm.portname' 14:25:38 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:38 INFO - PROCESS | 1649 | 2017-02-16 14:25:38.216 plugin-container[1651:9994] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a0b, name = 'com.apple.CFPasteboardClient' 14:25:38 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:38 INFO - PROCESS | 1649 | 2017-02-16 14:25:38.216 plugin-container[1651:9994] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:25:38 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 14:25:38 INFO - PROCESS | 1649 | colorDepth:24 14:25:38 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 14:25:38 INFO - PROCESS | 1649 | __metrics 14:25:38 ERROR - PROCESS | 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3197: TypeError: this.tabs is undefined 14:25:39 INFO - TEST-INFO | 1649: exit 0 14:25:39 INFO - Browser initialized. 14:25:39 INFO - Running cycle 1/1 for kraken test... 14:25:39 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/T/tmpWBuiZy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:25:41 INFO - PROCESS | 1652 | 2017-02-16 14:25:41.426 plugin-container[1653:10119] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4247, name = 'com.apple.tsm.portname' 14:25:41 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:41 INFO - PROCESS | 1652 | 2017-02-16 14:25:41.426 plugin-container[1653:10119] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b03, name = 'com.apple.CFPasteboardClient' 14:25:41 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:25:41 INFO - PROCESS | 1652 | 2017-02-16 14:25:41.426 plugin-container[1653:10119] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:25:51 INFO - PROCESS | 1652 | RSS: Main: 178139136 14:25:51 INFO - PROCESS | 1652 | 14:25:54 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 14:25:54 INFO - PROCESS | 1652 | RSS: Main: 191197184 14:25:54 INFO - PROCESS | 1652 | 14:25:57 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 14:25:58 INFO - PROCESS | 1652 | RSS: Main: 198520832 14:25:58 INFO - PROCESS | 1652 | 14:26:01 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 14:26:01 INFO - PROCESS | 1652 | RSS: Main: 202907648 14:26:01 INFO - PROCESS | 1652 | 14:26:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 14:26:04 INFO - PROCESS | 1652 | RSS: Main: 203788288 14:26:04 INFO - PROCESS | 1652 | 14:26:06 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:07 INFO - PROCESS | 1652 | RSS: Main: 204005376 14:26:07 INFO - PROCESS | 1652 | 14:26:10 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:10 INFO - PROCESS | 1652 | RSS: Main: 208515072 14:26:10 INFO - PROCESS | 1652 | 14:26:13 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:14 INFO - PROCESS | 1652 | RSS: Main: 208445440 14:26:14 INFO - PROCESS | 1652 | 14:26:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 14:26:18 INFO - PROCESS | 1652 | RSS: Main: 207712256 14:26:18 INFO - PROCESS | 1652 | 14:26:19 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:26:20 INFO - PROCESS | 1652 | RSS: Main: 206884864 14:26:20 INFO - PROCESS | 1652 | 14:26:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:23 INFO - PROCESS | 1652 | RSS: Main: 206991360 14:26:23 INFO - PROCESS | 1652 | 14:26:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:25 INFO - PROCESS | 1652 | RSS: Main: 207032320 14:26:25 INFO - PROCESS | 1652 | 14:26:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:29 INFO - PROCESS | 1652 | RSS: Main: 207278080 14:26:29 INFO - PROCESS | 1652 | 14:26:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:32 INFO - PROCESS | 1652 | RSS: Main: 207454208 14:26:32 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 14:26:34 INFO - PROCESS | 1652 | RSS: Main: 208863232 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | __start_tp_report 14:26:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 14:26:34 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 14:26:34 INFO - PROCESS | 1652 | |i|pagename|runs| 14:26:34 INFO - PROCESS | 1652 | |0;ai-astar;106;119;120;117;131;119;119;119;121;152 14:26:34 INFO - PROCESS | 1652 | |1;audio-beat-detection;141;115;124;153;115;111;109;120;138;113 14:26:34 INFO - PROCESS | 1652 | |2;audio-dft;199;197;196;199;198;197;195;200;200;195 14:26:34 INFO - PROCESS | 1652 | |3;audio-fft;79;59;61;108;82;80;57;62;97;85 14:26:34 INFO - PROCESS | 1652 | |4;audio-oscillator;85;69;88;72;75;70;85;69;69;89 14:26:34 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;115;134;84;130;136;85;101;122;90;105 14:26:34 INFO - PROCESS | 1652 | |6;imaging-darkroom;95;100;113;140;120;124;123;90;149;91 14:26:34 INFO - PROCESS | 1652 | |7;imaging-desaturate;135;134;88;104;121;88;77;138;132;94 14:26:34 INFO - PROCESS | 1652 | |8;json-parse-financial;53;56;56;56;65;81;92;61;58;60 14:26:34 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;72;107;110;108;73;69;67;69;82;101 14:26:34 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;83;83;87;85;82;89;83;85;93;84 14:26:34 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;140;139;140;139;142;142;144;141;187;139 14:26:34 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;165;165;164;167;234;216;165;168;161;163 14:26:34 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;68;65;66;67;67 14:26:34 INFO - PROCESS | 1652 | __end_tp_report 14:26:34 INFO - PROCESS | 1652 | __start_cc_report 14:26:34 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,944 14:26:34 INFO - PROCESS | 1652 | __end_cc_report 14:26:34 INFO - PROCESS | 1652 | __startTimestamp1487283994899__endTimestamp 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | ------- Summary: start ------- 14:26:34 INFO - PROCESS | 1652 | Number of tests: 14 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:122.30 Median:119.50 stddev:12.03 (10.1%) stddev-sans-first:11.22 14:26:34 INFO - PROCESS | 1652 | Values: 106.0 119.0 120.0 117.0 131.0 119.0 119.0 119.0 121.0 152.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:123.90 Median:122.00 stddev:14.98 (12.3%) stddev-sans-first:14.55 14:26:34 INFO - PROCESS | 1652 | Values: 141.0 115.0 124.0 153.0 115.0 111.0 109.0 120.0 138.0 113.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:197.60 Median:198.50 stddev:1.90 (1.0%) stddev-sans-first:1.94 14:26:34 INFO - PROCESS | 1652 | Values: 199.0 197.0 196.0 199.0 198.0 197.0 195.0 200.0 200.0 195.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:77.00 Median:79.50 stddev:17.22 (21.7%) stddev-sans-first:18.25 14:26:34 INFO - PROCESS | 1652 | Values: 79.0 59.0 61.0 108.0 82.0 80.0 57.0 62.0 97.0 85.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:80.00 stddev:8.58 (10.7%) stddev-sans-first:8.61 14:26:34 INFO - PROCESS | 1652 | Values: 85.0 69.0 88.0 72.0 75.0 70.0 85.0 69.0 69.0 89.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:135.00 stddev:20.08 (14.9%) stddev-sans-first:21.22 14:26:34 INFO - PROCESS | 1652 | Values: 115.0 134.0 84.0 130.0 136.0 85.0 101.0 122.0 90.0 105.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:144.50 stddev:20.49 (14.2%) stddev-sans-first:20.48 14:26:34 INFO - PROCESS | 1652 | Values: 95.0 100.0 113.0 140.0 120.0 124.0 123.0 90.0 149.0 91.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:111.10 Median:107.50 stddev:23.40 (21.8%) stddev-sans-first:23.16 14:26:34 INFO - PROCESS | 1652 | Values: 135.0 134.0 88.0 104.0 121.0 88.0 77.0 138.0 132.0 94.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:60.50 stddev:12.68 (21.0%) stddev-sans-first:12.84 14:26:34 INFO - PROCESS | 1652 | Values: 53.0 56.0 56.0 56.0 65.0 81.0 92.0 61.0 58.0 60.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:85.80 Median:69.00 stddev:18.40 (26.7%) stddev-sans-first:18.82 14:26:34 INFO - PROCESS | 1652 | Values: 72.0 107.0 110.0 108.0 73.0 69.0 67.0 69.0 82.0 101.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:3.41 (4.0%) stddev-sans-first:3.50 14:26:34 INFO - PROCESS | 1652 | Values: 83.0 83.0 87.0 85.0 82.0 89.0 83.0 85.0 93.0 84.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:145.30 Median:141.50 stddev:14.74 (10.4%) stddev-sans-first:15.51 14:26:34 INFO - PROCESS | 1652 | Values: 140.0 139.0 140.0 139.0 142.0 142.0 144.0 141.0 187.0 139.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:166.00 stddev:25.83 (15.6%) stddev-sans-first:27.04 14:26:34 INFO - PROCESS | 1652 | Values: 165.0 165.0 164.0 167.0 234.0 216.0 165.0 168.0 161.0 163.0 14:26:34 INFO - PROCESS | 1652 | 14:26:34 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 14:26:34 INFO - PROCESS | 1652 | Values: 66.0 67.0 67.0 66.0 67.0 68.0 65.0 66.0 67.0 67.0 14:26:34 INFO - PROCESS | 1652 | -------- Summary: end -------- 14:26:34 INFO - PROCESS | 1652 | 14:26:35 INFO - TEST-INFO | 1652: exit 0 14:26:35 INFO - TEST-OK | kraken | took 60409ms 14:26:35 INFO - SUITE-END | took 1175s 14:26:36 INFO - Completed test suite (00:19:35) 14:26:36 INFO - javascript benchmark 14:26:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7372.580770114386, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.6679198684137, 3570.785752854829, 3616.945745813813, 3618.203995121074, 3619.950214437813, 4808.927866082012, 5884.705764711764, 5982.850428739278, 5999.610025348355, 6000.489958353545, 5915.763369465227, 5985.281766188053, 5995.13070604762, 6009.068594367869, 6010.0, 4083.9994201420695, 5342.946570534294, 5384.892302153955, 5424.864378390552, 5440.3743569489425, 4579.290210017436, 5268.0, 5438.456154384549, 5456.372517160537, 5459.317585301837, 5310.15037593985, 5325.068113080215, 5420.295361602986, 5430.5384042356445, 5439.102548079562, 4340.978295108536, 4899.191633380488, 5436.619436639437, 5457.918131228034, 5502.614816962814, 5301.840944771663, 5415.10650742627, 5422.593305502063, 5424.105022671254, 5457.154141108134, 5782.653040817564, 5989.610675306091, 5998.910016349758, 6071.726772295257, 6096.390360963868, 6174.660393678346, 6186.474149697281, 6188.87622247557, 6227.0, 6240.063990401431, 5264.6051546134195, 6297.370262973712, 6319.715612797435, 6369.585976911486, 6373.075903993941, 6136.815895523141, 6143.539234557336, 6157.230346206769, 6159.84600384994, 6172.87654246917, 6240.0, 6299.401556852092, 6385.776497822554, 6414.1340918976275, 6455.903161452582, 6292.779752708633, 6296.5592408530965, 6300.779472718433, 6312.5265605078885, 6319.652419116901, 6331.145295385156, 6355.777547785898, 6356.809295721136, 6369.617822930639, 6448.193975753031, 6184.845378865564, 6196.47329976948, 6226.159468471698, 6230.813075607739, 6261.311255761862, 6240.937590624127, 6256.436920677161, 6269.144476147137, 6280.403361680633, 6284.994400895835, 3879.476270703475, 5138.075146473596, 5160.767765450564, 5170.302009228782, 5174.275601415729, 4497.100579884036, 4497.257952437811, 4525.434320709911, 4530.093981203772, 4624.722516649012, 6050.697465126814, 6051.606645568024, 6104.877902441926, 6112.847178820565, 6116.457510225689, 6349.047642853517, 6360.681965901686, 6363.172787537683, 6395.776147834804, 6397.840053998687, 5933.991221492357, 5998.580099393001, 5999.550033747487, 6037.879242415215, 6042.214512113485, 5625.184348269478, 5657.12314591239, 5660.349059858169, 5669.603127781098, 5677.148427735872, 6514.413702766774, 6524.608523488606, 6531.085648009187, 6544.476441884638, 6549.901751473827, 6219.378062193744, 6220.595661282002, 6263.843403914939, 6275.0, 6315.179026726496, 6516.73933042673, 6531.510136739668, 6541.051547525487, 6543.967280163569, 6581.80254592363, 6296.181496405621, 6306.0, 6311.368863113836, 6312.779052733133, 6316.242050953915, 6198.690065496798, 6265.342139075331, 6283.654399008098, 6318.968405157945, 6365.267994180544, 6129.509639228761, 6175.135481032748, 6270.561060725888, 6280.623162610258, 6301.4643755279485, 6231.345708700703, 6245.406686364788, 6252.280987686474, 6269.874602507833, 6282.811515654537, 5066.203818497396, 6099.024156134997, 6172.598781079216, 6230.06549017651, 6279.026750853625, 6108.09924418988, 6181.196444462191, 6193.783217587363, 6195.101710251898, 6268.0, 6127.387261273837, 6206.906896396648, 6213.875722485615, 6220.284667263141, 6246.063090536456], "value": 5832.630687124471, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.28288849614063, 494.93318402015717, 526.1949217696924, 540.3758658749147, 562.052940794761, 38096.0, 42528.78735606325, 42612.14775704488, 42615.14769704608, 42617.7869110654, 40719.79640101796, 41361.96595085124, 41393.96515087124, 41433.964150896165, 41443.756687299356, 9365.297602679791, 9547.809043819154, 9555.996620354867, 9567.186789122932, 9599.95200023999, 8226.0, 9462.479563623998, 9486.478243696594, 9524.238060955107, 9596.040395960417, 8154.8776768348525, 9434.905650943472, 9509.286803489766, 9551.140397364235, 9591.328606997513, 9404.576794044284, 9442.575084121198, 9496.572654230577, 9562.28282878787, 9598.328117031811, 8208.46644968075, 9425.151736343762, 9440.480773557452, 9470.14768670823, 9562.952185239099, 39973.0, 40076.398854017214, 40348.79825600883, 40364.59635403638, 40442.39336409956, 3307.7188438982716, 3494.9126271843406, 3534.452159915217, 3562.340966921128, 3984.342583473723, 23980.400489987715, 29196.270093247625, 29686.406271874443, 31409.0, 31487.527687084712, 2905.825650460979, 3154.794938329001, 3202.455582550972, 3241.918952026195, 3370.561826962504, 495838.0, 497502.0, 497626.0, 500476.0, 500691.0, 57012.0, 57151.0, 57197.71401142968, 57505.71247143738, 57679.423205768246, 59389.70305148533, 59540.0, 59550.0, 59659.403405965386, 59706.0, 16381.67236655284, 16582.0, 16608.335666573443, 16614.91692541554, 16743.83256167447, 12860.485580576858, 12919.96640268795, 12959.352032398343, 12963.222206667442, 12964.935175324252, 13678.905687544973, 14703.0, 15254.923725381303, 15416.460423885335, 15571.688566228839, 5243.947560524422, 6060.969695151496, 6160.691965401712, 6179.783707570214, 6192.752289908353, 907.7866701325183, 925.121134921827, 994.7463396833762, 1019.4189312092185, 1111.9499622517005, 29158.854205728836, 29160.270993224916, 29536.852315738284, 29855.0, 29891.0, 898.9572096368181, 1045.8901815309434, 1069.4225118436113, 1101.6419663609358, 1139.6125317392127, 13903.721925561635, 14268.571942841523, 15264.3894244229, 15266.931314807856, 15439.552275766386, 627361.0, 631941.0, 632436.0, 632818.0, 634754.0, 56621.0, 56813.43186568082, 57202.427975720544, 57228.56928576736, 57341.42658573361, 1343.4156142078227, 1382.861713828609, 1403.698204885934, 1414.886809055273, 1418.14202407544, 29031.838726450704, 29859.850700746356, 29981.55027674543, 30093.247668808453, 30352.78588856421, 47750.52249477461, 48399.75800120977, 48797.512024879295, 48879.75560122177, 48926.0, 517374.0, 521788.0, 524656.0, 525379.0, 526335.0, 25311.74688253094, 25390.111346102796, 25427.237182884543, 25666.8716656423, 25674.486510270064, 43590.56409435865, 44093.677189684364, 44278.0, 44372.77813610911, 44793.77603111963, 35482.11294717653, 36218.275634486636, 36435.635643643225, 37219.62780372162, 37623.81188094042, 36226.8188659055, 36413.01110074021, 37139.0, 37231.0, 37529.6247037537, 28560.285992849513, 32065.6793432072, 36691.81654091713, 36776.0805979842, 37188.07029824276, 31059.689403106582, 33056.66943330632, 33089.50365744564, 33136.1715957103, 33217.83391083029, 21679.34961951144, 23637.963092548616, 25181.118660846783, 25361.0, 25536.48927021412], "value": 19327.81737208834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.912557297889, 351.811780697327, 385.91509867829086, 404.23599397139395, 419.1428528658892, 18838.43484695458, 20469.590608187864, 21147.47131321718, 21306.57386852264, 21359.252426165087, 20257.49356266094, 20545.075471603777, 20598.691019634716, 20768.792312076876, 20943.05756240969, 5789.594728369016, 5977.701114944235, 7370.74202402916, 7710.383169346467, 7785.610719464033, 4607.417523537998, 7327.706891724325, 7550.244975502434, 7680.884786728176, 7716.035495563055, 7686.769396918102, 7759.767206983771, 7764.2235776422185, 7772.0, 7773.300402963732, 7359.190489046201, 7630.329384715361, 7638.312551870303, 7669.348105411047, 7675.884861727079, 7155.177154627232, 7397.334239918379, 7419.888701669479, 7491.175970643225, 7494.775156745306, 28210.0, 28322.858385708147, 28660.426791464262, 28788.0, 29210.831566737306, 2354.6350315701093, 2472.9629055564183, 2501.699796024489, 2528.077251803097, 2813.353761633454, 14893.70212595742, 15717.0, 16198.190090495427, 16788.748168777478, 17029.91485042567, 2023.4132101690493, 2096.4863608416035, 2116.1323857218467, 2124.150339864051, 2136.59404713104, 134027.0, 134063.0, 134690.6530934688, 139328.0, 139648.30175849056, 17385.391511297043, 21736.565268694536, 21947.780522194895, 22240.888795556242, 22273.77726222717, 35940.64059359425, 36093.27813443769, 36418.45372319417, 36634.0, 36688.44967325492, 10855.40295283767, 10937.671869843918, 10949.4525273736, 11172.664820055412, 11304.15218858589, 8987.865182022275, 8996.0, 9034.412763170505, 9042.502662353501, 9166.312526560534, 7495.437842161859, 7998.520088794691, 9892.0, 9996.850047249298, 10009.698739164007, 1629.9266533006044, 1721.9397321093952, 1726.2318268370705, 3862.362710152793, 3971.225611005826, 871.6687658689784, 877.9429337093069, 926.6386109417333, 929.9116583924516, 979.1628157924872, 17846.28614855391, 18701.784384014994, 20882.164713411596, 21374.14503419877, 21554.13783448676, 861.1517655109712, 954.61815273891, 957.4303289542711, 960.6589660670501, 1018.8828284747201, 10755.0, 11120.110391168688, 11190.38452885083, 11319.434028298552, 11395.487203075882, 557890.0, 561362.0, 590804.0, 597200.0, 627863.0, 130734.0, 131511.0, 133216.3339183298, 135425.0, 137421.0, 952.1097773581723, 972.9221662267001, 1017.6234793126442, 1042.8279333909973, 1046.4349251404308, 19092.71360929615, 19631.93864644192, 19737.605247894673, 19761.01194940276, 19981.000949952155, 47639.52360476351, 55508.0, 56735.14897276462, 57182.0, 58960.0, 75569.0, 77597.0, 77687.44625107579, 77760.0, 77869.61065194638, 6896.241413444417, 7292.927070729224, 7308.8538229234055, 7577.0, 7798.220177982156, 10758.354498730101, 10820.404877731486, 12269.263844169378, 12303.44634491432, 12903.032272579781, 10482.947585262025, 10546.525406356886, 10637.468126593485, 10888.658938328297, 10994.230403871652, 10510.0, 10790.67627971162, 10848.294860834021, 10915.454227288445, 11006.229563930448, 5762.250907382014, 6450.903236451363, 10697.502349670896, 10836.837447438136, 10878.51046702916, 7320.743773967885, 7331.303526165006, 7475.028246327943, 7496.325330720261, 7635.580043097683, 8961.507117108622, 9033.0, 10632.734181645212, 10799.244052916534, 10833.837492437462], "value": 10835.619446148246, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.1273148842183, 1515.8559936806002, 1689.6958547461452, 1793.1572161084302, 1839.5033340997923, 7568.470207085506, 7793.53238805672, 8073.555954422504, 8499.490030598161, 8519.616617252223, 8147.674093036271, 8408.159184081589, 8421.410501264914, 8422.494650320985, 8444.577771111435, 2032.9835082458771, 2334.241371554243, 2371.620540713486, 2389.199618127929, 2394.3415560720855, 2344.9179278725246, 2373.41851246444, 2382.5711371953043, 2407.2537513370826, 2407.5064611754638, 2000.4998750312423, 2315.8957846896847, 2331.778481044307, 2353.564590550745, 2378.4886249456363, 1934.3809980806077, 2319.9188028419094, 2328.7205535335697, 2343.6250199968094, 2346.6245400735884, 2375.5367703297866, 2383.630537266709, 2389.7371289158355, 2397.916072937439, 2416.395901024744, 7235.602041887694, 7818.45270831042, 8249.546274954875, 8442.15578442157, 8463.111373305837, 4760.500147484534, 5188.9740551297, 5200.8179713710215, 5201.817936372209, 5223.921641175385, 3227.144806626246, 3354.194993201638, 3482.460218666111, 3539.592946811098, 3570.4465807799834, 942.9811403771886, 1036.4921188617523, 1062.2086545523634, 1113.560143743225, 1141.5034460009922, 10789.946050269777, 10811.675649730521, 10874.945625271903, 10914.963078507608, 10916.890831091747, 4484.910301793946, 4591.737272250158, 4645.558671926162, 4674.298855171752, 4718.820294926269, 9293.953530232306, 9321.533923303808, 9353.719388418358, 9355.859662105075, 9395.248380129573, 5181.4041385240425, 5192.506711862367, 5203.063448579292, 5205.375354957429, 5212.087884620177, 4286.549912259168, 4328.523862375137, 4760.666753327234, 4789.760511974388, 4803.759812009385, 3824.8661296854475, 3880.476135721698, 3955.149642826806, 3962.663173630216, 3974.0263635408933, 1134.5178299222798, 1302.5701518499063, 1303.5633062923837, 1309.508934149694, 1320.0825426328802, 806.7781360126012, 879.3712495565701, 884.4869975414244, 893.7542175901549, 918.8300164469595, 4469.575390337913, 5566.860828479239, 5580.497755202051, 5767.423257674199, 5870.5010074144175, 934.5981228071994, 972.6060945317158, 987.2990176974429, 991.4546999150439, 1014.9289549731448, 3840.0, 3881.204353107606, 3882.2817778710464, 3915.686745060388, 3996.680265578747, 9856.31005829585, 10169.898301017043, 10175.694729158136, 10176.491175441346, 10185.9490702546, 9323.580438880266, 9550.044995500533, 9834.60661573529, 10013.0, 10023.799524009624, 6719.865602687919, 7457.216992215847, 7675.462717609826, 7739.883901741478, 7920.128785833554, 4812.374391329105, 5808.7095645218415, 5856.795012174553, 5964.224650795542, 6123.9693801532485, 7286.6720997556295, 8161.183881611792, 8997.82004359896, 9421.340506164503, 9449.763755906157, 8260.380471464545, 8890.888638920134, 8959.0, 9521.809563808823, 9577.760555986157, 6522.869542609216, 6712.798616041527, 6912.239653637996, 7021.227664956748, 7200.207977122617, 7676.232376762502, 7814.492058016211, 7858.567778771993, 7865.252800983897, 7880.975473188449, 7038.436925046087, 7221.31397517235, 7239.239879812544, 7248.492605517563, 7309.597972111372, 7013.333733295329, 7057.435405167472, 7076.469264805057, 7181.676824543013, 7187.892181617175, 6714.563553369211, 6721.697523611547, 6750.763723269662, 6778.932210678027, 6800.115984922127, 4791.880202994953, 4794.688345257547, 4817.542333478314, 4837.443693975097, 4845.8061677533915, 4807.399075115611, 4872.658913875995, 4884.804607815648, 4959.20652695567, 4978.153713868724], "value": 4418.25540951235, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [248.85566371504518, 314.66645355922725, 323.40977715668896, 324.14264271003185, 325.890826573098, 4644.3730096436975, 5232.8691782705455, 5337.412884582693, 5518.944810551893, 5525.944740552593, 4686.953130468694, 5247.790088396469, 5459.754311056002, 5470.17947307904, 5479.123340265548, 3675.7210529471763, 4140.689448291375, 4244.702870799038, 4249.893752656178, 4252.447181866369, 3718.40505519117, 3914.9608503915024, 4176.7911604419805, 4267.167902259061, 4285.914281714364, 3442.397580423416, 4126.277901367249, 4138.689598280126, 4156.625903668669, 4170.791460426982, 4125.339945608704, 4135.932033982994, 4148.315527937887, 4148.502179738451, 4154.667626589866, 3435.5018522314376, 3548.201654627714, 3575.76757510761, 3598.514200582914, 3600.9557228403733, 4627.537246275379, 4845.345878306419, 5326.201069839516, 5348.438413966555, 5356.009138309425, 4170.186813571355, 4183.435236243099, 4190.455240818705, 4311.545894443531, 4384.013596940695, 5376.301080859464, 5770.980156945077, 5777.768889244468, 5795.189992306376, 5807.535397168216, 3927.410888366739, 3953.881383558498, 3955.584663610337, 3966.3852102924093, 3976.7216294859372, 6059.6364218147055, 6106.3896757947905, 6122.540809439265, 6137.9079313810325, 6145.969270153665, 3891.9221615568094, 3951.3677811550015, 3984.6613037891525, 4028.2950483665827, 4032.2338755636333, 4051.5745846686264, 4102.097538541516, 4104.42538044674, 4109.760180701524, 4143.854965076268, 4064.8577299794365, 4744.715317080986, 4809.893724443327, 4829.444613869379, 4874.512548745168, 5156.355455568054, 5631.211630371751, 5804.126957156234, 5887.587868849139, 5907.7046147692445, 1147.0, 1300.90243231758, 1335.9666008349868, 1349.0354396606474, 1349.1230700044853, 873.2926329672986, 882.8984666763276, 900.8558630619069, 901.369041670833, 908.5775114571755, 4055.904905675451, 4440.755758433317, 4972.925406118911, 5166.062726477571, 5199.532042116228, 5147.124988751922, 5225.6603320784025, 5541.5289700375115, 5704.572157088235, 5828.562857785683, 4529.68292219548, 4854.129706288234, 5007.9499205008215, 5219.947800522022, 5263.26314315996, 2573.189445324754, 2744.643196384497, 2789.7499413183414, 2911.9417611648073, 2986.7013298670395, 4928.950710492921, 5296.523312901857, 5356.517913387814, 5392.923724366147, 6007.759689612367, 4626.097910907408, 5329.200619907045, 5702.6354749787, 5708.828735137952, 5791.189233507313, 5144.897102058013, 5453.781848726086, 5570.805021824217, 5823.088455772114, 5852.941470585325, 5040.470750571138, 5076.42630784458, 5387.784488620411, 5452.182172673972, 5789.421057894177, 4703.45910220329, 5236.0, 5510.311211098613, 5608.495235428831, 5657.660540367591, 5582.720863956704, 5839.408763610434, 5907.881842363215, 5932.7033648318275, 5978.312494063064, 3552.9644703553668, 3727.807101727421, 3787.0532366908274, 3841.5966323535627, 3879.3792993122092, 5200.63595548308, 5609.831705048855, 5707.032343181605, 5780.364159942319, 5989.970050149721, 5848.970755146197, 5887.764489420375, 5918.674472904032, 5937.2578427696535, 5951.761929522944, 4956.55391014796, 5920.365437380325, 5923.933691935493, 5948.196993405835, 5994.430529099728, 4710.623150148049, 5017.422996355466, 5712.285964254468, 5734.569907256889, 5747.942520574908, 4930.0419748150825, 5000.0, 5816.621919575214, 5972.820815375546, 5987.75459202799, 4859.809346710079, 5380.892382152413, 5814.900495150993, 5832.358440571449, 5907.877503274364], "value": 4130.774827998281, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.8253447767381, 657.3919124809549, 720.747738291598, 741.5698894641108, 767.5241350362775, 14349.497767578137, 14876.47932322369, 15199.77200341993, 15282.923585382085, 15348.386064557419, 13814.240216788072, 13888.305584720749, 13977.371018304175, 13978.720425591482, 14039.578812635636, 861.5218553702708, 875.9562021898911, 877.5875338590852, 878.1920633017639, 878.9472631642122, 826.499967519651, 861.6682577207789, 864.235151890575, 867.8524650809346, 870.5342641686699, 771.3212373111654, 880.0847118996236, 882.1399135842566, 900.1898291537603, 900.4777229207077, 891.4161224397998, 892.085612247445, 895.0914821456195, 896.0054339682947, 896.5875697179305, 649.7628365646552, 655.4952686431421, 667.3360006793272, 667.8263651450609, 667.8397184675691, 13917.652058698512, 14107.717845643132, 14283.714325713427, 14290.713835754728, 14314.069585477015, 13229.12504994011, 13390.0, 13528.526501572398, 13598.660033499242, 14023.649408764863, 11306.321620702702, 11380.544778208945, 11575.0161236295, 11623.302601843916, 11668.416579171093, 3719.1817800083936, 3744.700423966076, 3943.5464921533817, 3970.3845903884944, 3980.86066987654, 62870.0, 90506.54746726224, 92987.53506232493, 95772.0, 96338.55492167623, 10614.787704245871, 10660.680179594625, 10689.251752377259, 10925.453727313603, 11016.283941543934, 17598.208080636403, 20505.692414613794, 20894.37316880496, 20977.0, 21112.838793866176, 7865.4494185406475, 7934.841303173905, 8001.319887809485, 8108.5945702714625, 8126.878096828552, 4387.298032314879, 4391.429114215195, 4403.163398954189, 4416.0, 4500.099980004013, 3348.6149092854635, 3397.9490307645406, 3446.5864096308605, 3451.326991236735, 3466.7746596471147, 569.9287589051369, 576.5618130220978, 635.6885126288086, 637.1303171171318, 657.8190997475732, 562.8874225154904, 646.4892734739503, 654.3489228217953, 659.5727721983149, 675.9222689390783, 7943.1972517376325, 8781.463243932414, 9187.127222913812, 9222.76943076415, 9312.255019598417, 622.3682961793783, 657.3065415986181, 680.1633990192091, 685.6126288646899, 687.7180356053993, 4185.727927684691, 4306.457700176785, 4382.211201983673, 4544.227481328182, 4560.749158796231, 65904.6819063616, 75996.86004709934, 115562.84437155689, 117154.0, 117450.0, 93869.0, 99756.0, 102025.0, 103440.48279758553, 103834.0, 44913.87715307144, 60854.4786380344, 61015.69492152511, 62223.0, 93651.53174234086, 8817.878049143925, 8849.247813935888, 8903.955480222558, 8923.41997770143, 9057.54712264371, 53077.7346113267, 58444.0, 58882.822343553744, 59080.704596476746, 60698.393016069276, 81453.0, 82289.58855205686, 83354.58322708348, 85409.14590854011, 87326.0, 11156.776864462827, 11297.7740445189, 11403.657890263305, 11642.41787910618, 11679.883201167879, 12099.81850272229, 12403.689907752378, 12663.493460261854, 12685.23888566689, 12771.93614031924, 11161.720956975816, 11856.70358241051, 11905.226160299553, 12047.939760301142, 12274.877251227374, 11514.194006419806, 11886.762264754829, 12021.278723276631, 12120.878791211975, 12195.695107622025, 11500.53997840077, 11641.941790290994, 11733.76532469363, 11798.52805887755, 12021.819672704742, 9621.230301575997, 9795.9020409795, 9970.351927124713, 10038.1467575254, 10048.397096174253, 9169.961263527686, 9202.631894724136, 10089.89910100919, 10207.438590877277, 10256.846147307648], "value": 7202.554843779512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 119.0, 120.0, 117.0, 131.0, 119.0, 119.0, 119.0, 121.0, 152.0], "value": 122.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 124.0, 153.0, 115.0, 111.0, 109.0, 120.0, 138.0, 113.0], "value": 123.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 196.0, 199.0, 198.0, 197.0, 195.0, 200.0, 200.0, 195.0], "value": 197.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 61.0, 108.0, 82.0, 80.0, 57.0, 62.0, 97.0, 85.0], "value": 77.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 88.0, 72.0, 75.0, 70.0, 85.0, 69.0, 69.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 134.0, 84.0, 130.0, 136.0, 85.0, 101.0, 122.0, 90.0, 105.0], "value": 110.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 113.0, 140.0, 120.0, 124.0, 123.0, 90.0, 149.0, 91.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 88.0, 104.0, 121.0, 88.0, 77.0, 138.0, 132.0, 94.0], "value": 111.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 56.0, 56.0, 65.0, 81.0, 92.0, 61.0, 58.0, 60.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 107.0, 110.0, 108.0, 73.0, 69.0, 67.0, 69.0, 82.0, 101.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 87.0, 85.0, 82.0, 89.0, 83.0, 85.0, 93.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 140.0, 139.0, 142.0, 142.0, 144.0, 141.0, 187.0, 139.0], "value": 145.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 164.0, 167.0, 234.0, 216.0, 165.0, 168.0, 161.0, 163.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 68.0, 65.0, 66.0, 67.0, 67.0], "value": 66.6, "unit": "score"}]}]} 14:26:36 INFO - Return code: 0 14:26:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:26:36 ERROR - # TBPL SUCCESS # 14:26:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:26:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:26:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:26:36 INFO - 2017-02-16 14:26:36.246 screenresolution[1657:10506] starting screenresolution argv=screenresolution get 14:26:36 INFO - 2017-02-16 14:26:36.248 screenresolution[1657:10506] Display 0: 1600x1200x32@60 14:26:36 INFO - 2017-02-16 14:26:36.255 screenresolution[1658:10509] starting screenresolution argv=screenresolution list 14:26:36 INFO - Available Modes on Display 0 14:26:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:26:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:26:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:26:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:26:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:26:36 INFO - Intel Iris: 14:26:36 INFO - Chipset Model: Intel Iris 14:26:36 INFO - Type: GPU 14:26:36 INFO - Bus: Built-In 14:26:36 INFO - VRAM (Dynamic, Max): 1536 MB 14:26:36 INFO - Vendor: Intel (0x8086) 14:26:36 INFO - Device ID: 0x0a2e 14:26:36 INFO - Revision ID: 0x0009 14:26:36 INFO - Displays: 14:26:36 INFO - Display: 14:26:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:26:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:26:36 INFO - Display Serial Number: 1600x1200 60 14:26:36 INFO - Main Display: Yes 14:26:36 INFO - Mirror: Off 14:26:36 INFO - Online: Yes 14:26:36 INFO - Rotation: Supported 14:26:36 INFO - Return code: 0 14:26:36 INFO - Running post-action listener: _resource_record_post_action 14:26:36 INFO - [mozharness: 2017-02-16 22:26:36.497111Z] Finished run-tests step (success) 14:26:36 INFO - Running post-run listener: _resource_record_post_run 14:26:36 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 40060928; Write bytes: 502961152; Read time: 392; Write time: 1651 14:26:36 INFO - TinderboxPrint: CPU usage
54.3% 14:26:36 INFO - TinderboxPrint: I/O read bytes / time
40,060,928 / 392 14:26:36 INFO - TinderboxPrint: I/O write bytes / time
502,961,152 / 1,651 14:26:36 INFO - TinderboxPrint: CPU idle
2,192.7 (45.7%) 14:26:36 INFO - TinderboxPrint: CPU system
965.7 (20.1%) 14:26:36 INFO - TinderboxPrint: CPU user
1,635.2 (34.1%) 14:26:36 INFO - TinderboxPrint: Swap in / out
245,985,280 / 0 14:26:36 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192922112; Write bytes: 194361344; Read time: 18229; Write time: 455 14:26:36 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 35837952; Write bytes: 307215360; Read time: 361; Write time: 1191 14:26:36 INFO - Running post-run listener: _upload_blobber_files 14:26:36 INFO - Blob upload gear active. 14:26:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:26:36 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 14:26:36 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'] 14:26:36 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 14:26:37 INFO - (blobuploader) - INFO - Open directory for files ... 14:26:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:26:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:26:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:38 INFO - (blobuploader) - INFO - Done attempting. 14:26:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:26:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:39 INFO - (blobuploader) - INFO - Done attempting. 14:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:26:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:26:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:26:41 INFO - (blobuploader) - INFO - Done attempting. 14:26:41 INFO - (blobuploader) - INFO - Iteration through files over. 14:26:41 INFO - Return code: 0 14:26:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:26:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:26:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4307618dc13a1a2da6288ae4b483c4087722bde856b21b7a5477f16e6849b0157a124118042bc5fead475952c56b5300059047438a963505ffe5b4ad67308e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec90c2c38f69010cc4e8bc6719afb59b1d96c171ae3c3296a0d6e87dfbbcd8711e79036e4392d61e2d2aa0f3942ab458098ade20c74838e4ec484e7cb52da97b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4adf212c453ab12056ecda8631e89e0df1281c5f8fa95ea8d4ebc741064d4d6fb610a270b6fe60fe0abccded87cd32bb5101a23669456184f6adbb24f57bdd41"} 14:26:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:26:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:26:41 INFO - Contents: 14:26:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4307618dc13a1a2da6288ae4b483c4087722bde856b21b7a5477f16e6849b0157a124118042bc5fead475952c56b5300059047438a963505ffe5b4ad67308e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec90c2c38f69010cc4e8bc6719afb59b1d96c171ae3c3296a0d6e87dfbbcd8711e79036e4392d61e2d2aa0f3942ab458098ade20c74838e4ec484e7cb52da97b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4adf212c453ab12056ecda8631e89e0df1281c5f8fa95ea8d4ebc741064d4d6fb610a270b6fe60fe0abccded87cd32bb5101a23669456184f6adbb24f57bdd41"} 14:26:41 INFO - Running post-run listener: copy_logs_to_upload_dir 14:26:41 INFO - Copying logs to upload dir... 14:26:41 INFO - mkdir: /builds/slave/test/build/upload/logs 14:26:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.638801 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-02-16 14:26:41.715477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 14:26:41.718790) ========= 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.vga8ByllxD/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.UJu5SOj9xf/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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/4307618dc13a1a2da6288ae4b483c4087722bde856b21b7a5477f16e6849b0157a124118042bc5fead475952c56b5300059047438a963505ffe5b4ad67308e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec90c2c38f69010cc4e8bc6719afb59b1d96c171ae3c3296a0d6e87dfbbcd8711e79036e4392d61e2d2aa0f3942ab458098ade20c74838e4ec484e7cb52da97b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4adf212c453ab12056ecda8631e89e0df1281c5f8fa95ea8d4ebc741064d4d6fb610a270b6fe60fe0abccded87cd32bb5101a23669456184f6adbb24f57bdd41"} build_url:https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/PzZA1a79S6ud6Z6kr0awog/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4307618dc13a1a2da6288ae4b483c4087722bde856b21b7a5477f16e6849b0157a124118042bc5fead475952c56b5300059047438a963505ffe5b4ad67308e01", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ec90c2c38f69010cc4e8bc6719afb59b1d96c171ae3c3296a0d6e87dfbbcd8711e79036e4392d61e2d2aa0f3942ab458098ade20c74838e4ec484e7cb52da97b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4adf212c453ab12056ecda8631e89e0df1281c5f8fa95ea8d4ebc741064d4d6fb610a270b6fe60fe0abccded87cd32bb5101a23669456184f6adbb24f57bdd41"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-16 14:26:41.753399) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 14:26:41.753728) ========= 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.vga8ByllxD/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.UJu5SOj9xf/Listeners TMPDIR=/var/folders/jw/kvh0w009673bgvcgwhm3z30m00000w/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.005233 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-16 14:26:41.802952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 14:26:41.803273) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-16 14:26:41.803693) ========= ========= Total master_lag: 0.18 =========